[Pkg-pdns-maintainers] Bug#750484: pdns-recursor: Fatal error: Resolver binding to local query client socket: Cannot assign requested address

Tue Jun 3 19:11:24 UTC 2014

Package: pdns-recursor
Version: 3.3-3
Severity: normal
Tags: ipv6

Dear Maintainer,

   * What led up to the situation?
Trying boot up with pdns-recursor installed

   * What exactly did you do (or not do) that was effective (or
     ineffective)?

I think it's caused by binding to ipv6 interface.

I have this settings in my /etc/network/interfaces

iface eth0 inet6 static
  address 2a01:4f8:<private data, my main ipv6>
  netmask 64
  gateway fe80::1
  up ip addr add 2a01:4f8:<private data, my secondary ipv6>/64 dev eth0 preferred_lft 0

It happens only during boot. After system was booted I can start pdns-recursor normaly.

   * What was the outcome of this action?

Jun  3 22:26:05 s1 kernel: [    6.301579] r8169 0000:02:00.0: eth0: link down
Jun  3 22:26:05 s1 kernel: [    6.303850] ADDRCONF(NETDEV_UP): eth0: link is not ready
Jun  3 22:26:05 s1 kernel: [    7.183998] ip_tables: (C) 2000-2006 Netfilter Core Team
Jun  3 22:26:05 s1 mdadm[2303]: DeviceDisappeared event detected on md device /dev/md/0, component device Wrong-Level
Jun  3 22:26:05 s1 acpid: starting up with netlink and the input layer
Jun  3 22:26:05 s1 /usr/sbin/cron[2396]: (CRON) INFO (pidfile fd = 3)
Jun  3 22:26:05 s1 /usr/sbin/cron[2421]: (CRON) STARTUP (fork ok)
Jun  3 22:26:05 s1 acpid: 1 rule loaded
Jun  3 22:26:05 s1 acpid: waiting for events: event logging is off
Jun  3 22:26:05 s1 /usr/sbin/cron[2421]: (CRON) INFO (Running @reboot jobs)
Jun  3 22:26:05 s1 kernel: [    7.444154] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
Jun  3 22:26:05 s1 kernel: [    7.468226] ip6_tables: (C) 2000-2006 Netfilter Core Team
Jun  3 22:26:05 s1 ntpd[2420]: ntpd 4.2.6p5 at 1.2349-o Sat May 12 09:54:55 UTC 2012 (1)
Jun  3 22:26:05 s1 ntpd[2490]: proto: precision = 0.117 usec
Jun  3 22:26:05 s1 ntpd[2490]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
Jun  3 22:26:05 s1 ntpd[2490]: Listen and drop on 1 v6wildcard :: UDP 123
Jun  3 22:26:05 s1 ntpd[2490]: Listen normally on 2 lo 127.0.0.1 UDP 123
Jun  3 22:26:05 s1 ntpd[2490]: Listen normally on 3 eth0 78.46.61.217 UDP 123
Jun  3 22:26:05 s1 ntpd[2490]: Listen normally on 4 lo ::1 UDP 123
Jun  3 22:26:05 s1 ntpd[2490]: peers refreshed
Jun  3 22:26:05 s1 ntpd[2490]: Listening on routing socket on fd #21 for interface updates
Jun  3 22:26:05 s1 pdns_recursor[2444]: PowerDNS recursor 3.3 (C) 2001-2010 PowerDNS.COM BV (Jun 18 2012, 15:42:26, gcc 4.7.0) starting up
Jun  3 22:26:05 s1 pdns_recursor[2444]: PowerDNS comes with ABSOLUTELY NO WARRANTY. This is free software, and you are welcome to redistribute it according to the terms of the GPL version 2.
Jun  3 22:26:05 s1 pdns_recursor[2444]: Operating in 64 bits mode
Jun  3 22:26:05 s1 pdns_recursor[2444]: Reading random entropy from '/dev/urandom'
Jun  3 22:26:05 s1 pdns_recursor[2444]: Only allowing queries from: 127.0.0.0/8, 10.0.0.0/8, 192.168.0.0/16, 172.16.0.0/12, ::1/128, fe80::/10
Jun  3 22:26:05 s1 pdns_recursor[2444]: Will not send queries to: 127.0.0.0/8, 10.0.0.0/8, 192.168.0.0/16, 172.16.0.0/12, ::1/128, fe80::/10, 0.0.0.0, ::
Jun  3 22:26:05 s1 pdns_recursor[2444]: Enabling IPv6 transport for outgoing queries
Jun  3 22:26:05 s1 pdns_recursor[2444]: Inserting rfc 1918 private space zones
Jun  3 22:26:05 s1 pdns_recursor[2444]: Not decreasing socket buffer size from 229376 to 200000
Jun  3 22:26:05 s1 pdns_recursor[2444]: Listening for UDP queries on 127.0.0.1:53
Jun  3 22:26:05 s1 pdns_recursor[2444]: Not decreasing socket buffer size from 229376 to 200000
Jun  3 22:26:05 s1 pdns_recursor[2444]: Listening for UDP queries on [::1]:53
Jun  3 22:26:05 s1 pdns_recursor[2444]: Enabled TCP data-ready filter for (slight) DoS protection
Jun  3 22:26:05 s1 pdns_recursor[2444]: Listening for TCP queries on 127.0.0.1:53
Jun  3 22:26:05 s1 pdns_recursor[2444]: Listening for TCP queries on [::1]:53
Jun  3 22:26:05 s1 pdns_recursor[2444]: Calling daemonize, going to background
Jun  3 22:26:05 s1 pdns_recursor[2577]: Set effective group id to 116
Jun  3 22:26:05 s1 pdns_recursor[2577]: Set effective user id to 113
Jun  3 22:26:05 s1 pdns_recursor[2577]: Launching 2 threads
Jun  3 22:26:05 s1 pdns_recursor[2577]: Done priming cache with root hints
Jun  3 22:26:05 s1 pdns_recursor[2577]: Done priming cache with root hints
Jun  3 22:26:05 s1 pdns_recursor[2577]: Enabled 'epoll' multiplexer
Jun  3 22:26:05 s1 pdns_recursor[2577]: Fatal error: Resolver binding to local query client socket: Cannot assign requested address
Jun  3 22:26:06 s1 opendkim[2663]: OpenDKIM Filter v2.6.8 starting (args: -x /etc/opendkim.conf -u opendkim -P /var/run/opendkim/opendkim.pid)
Jun  3 22:26:07 s1 kernel: [    9.363553] r8169 0000:02:00.0: eth0: link up
Jun  3 22:26:07 s1 kernel: [    9.364161] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready

   * What outcome did you expect instead?

pdns-recursor started properly like ntpd earlier

-- System Information:
Debian Release: 7.5
  APT prefers stable
  APT policy: (500, 'stable')
Architecture: amd64 (x86_64)

Kernel: Linux 3.2.0-4-amd64 (SMP w/8 CPU cores)
Locale: LANG=en_US.UTF-8, LC_CTYPE=en_US.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash

Versions of packages pdns-recursor depends on:
ii  adduser      3.113+nmu3
ii  libc6        2.13-38+deb7u1
ii  libgcc1      1:4.7.2-5
ii  liblua5.1-0  5.1.5-4
ii  libstdc++6   4.7.2-5
ii  lsb-base     4.1+Debian8+deb7u1

Versions of packages pdns-recursor recommends:
pn  pdns-doc  <none>

pdns-recursor suggests no packages.

-- Configuration Files:
/etc/powerdns/recursor.conf changed:
allow-from=127.0.0.0/8, 10.0.0.0/8, 192.168.0.0/16, 172.16.0.0/12, ::1/128, fe80::/10
chroot=/var/chroot/pdns-recursor
dont-query=127.0.0.0/8, 10.0.0.0/8, 192.168.0.0/16, 172.16.0.0/12, ::1/128, fe80::/10
local-address=127.0.0.1 [::1]
local-port=53
query-local-address6=2a01:4f8:<private data, my secondary ipv6>
quiet=yes
setgid=pdns
setuid=pdns
version-string=PowerDNS Recursor

-- no debconf information