[dns-operations] BIND validation problem with some DE zones [was: Operational Note -- DNSSEC for DE]

Wolfgang Nagele wnagele at ripe.net
Tue May 24 18:48:28 UTC 2011


Hi,

I think this might be a timing issue. It seems that .DE has included DS records
in the zone _before_ this zone was available on all systems. In that case I
believe BIND trips if it reaches a server where it does not get any DNSKEY set
because it would be wrong for .de to hand out DS records if the zone itself was
not even signed. This can be verified by clearing the cache and retrying - if
one reaches a server that carries the DUdeZ it just works.

One can reproduce this scenario by configuring .de to use a static-stub zone
(only supported in 9.8) that redirects .de requests to one of the systems known
to already carry the DUdeZ as follows:

zone de {
  type static-stub;
  server-addresses { 194.246.96.1; }; // z.nic.de
};

In this case it seems to work (although granted, the static-stub thing might do
some more magic that I don't know about).

I believe that .de should have first been rolled out onto all servers using the
DUdeZ and _after_ that the DS records should have been introduced. Refer to for
instance .com rollout[1] that used this kind of timing.

Attached is a BIND 9.8 log of a failed lookup for exanames.de. As another
datapoint. BIND 9.6-ESV does not seem to be affected.

Regards,
Wolfgang

[1] http://www.ietf.org/mail-archive/web/dnsop/current/msg08990.html

On 5/24/11 17:39, Chris Thompson wrote:
> On May 24 2011, Peter Koch wrote:
> 
>> Dear list,
>>
>> this is to inform the wider operator community that DENIC has started the
>> deployment of a deliberately unvalidatable DE zone (DUdeZ) end of last
>> week. [...]
> 
> I have e-mailed Peter offlist about this, but as the scope of the
> problem looms larger, I should maybe post about it here as well as
> on bind-users, in case people prefer to discuss it here on dns-oarc.
> 
> I would welcome some indication that we are not the only site in the
> world seeing this, of course!
> 
> Here is a copy of my last bind-users posting::
> 
> On May 24 2011, I wrote:
> 
>> We are getting DNSSEC-related SERVFAILs on names in bund.de (e.g.
>> mx1.bind.de). This happens with all of BIND 9.7.3-P1, 9.7.4b1 and
>> 9.8.0-P1 configured with the root and dlv.isc.org trust anchors.
>>
>> However, I can't see what is actually wrong with it, using dig +cd as
>> necessary. All the signatures appear to have valid start/stop times, and
>> http://dnsviz.net/d/mx1.bund.de/dnssec/ seems pretty happy with it. There
>> are a lot of false trails (e.g. the DS records for it in "de") but that
>> shouldn't stop BIND finding the one that works (DLV in dlv.isc.org ->
>> KSK with tag 10923 -> ZSK with tag 4814), should it?
>>
>> It may be significant that this problem was reported to us on the same
>> day that obscured DNSKEY records were introduced into the "de" zone...
> 
> That seems almost certain to be the precipitating event, in fact.
> I can produce the same effect for all 31 zones that are both registered
> in dlv.isc.org *and* have a DS record in de:
> 
>  adns1.de.                           ralf-pulz.de.
>  brj-berlin.de.                      reichel-jens.de.
>  btw-kinderdorf.de.                  schrimpe.de.
>  buergerhaushalt-marzahn.de.         sgfun.de.
>  bund.de.                            sgmail.de.
>  com.de.                             stadtteilzeitung-nordwest.de.
>  exanames.de.                        stefan-gransow.de.
>  gun.de.                             stegranet.de.
>  idkom-networks.de.                  steinmuss.de.
>  ifw-dresden.de.                     unixbuero.de.
>  iks-jena.de.                        verein-kiekin.de.
>  ipse-online.de.                     wartenbergerhof.de.
>  judo-dresden.de.                    wikileaks.de.
>  ombudschaft.de.                     zrb-kiekin.de.
>  ombudschaft-jugendhilfe.de.
> 
> Among other oddities:
> 
>  dig +dnssec dnskey [zone] gives the right answer *without* the ad bit
>  dig +dnssec soa [zone] gives SERVFAIL, unless +cd is used as well.
-------------- next part --------------
now using logging configuration from config file
load_configuration: success
zone 0.IN-ADDR.ARPA/IN: starting load
zone 0.IN-ADDR.ARPA/IN: number of nodes in database: 0
zone 0.IN-ADDR.ARPA/IN: loaded
zone_settimer: zone 0.IN-ADDR.ARPA/IN: enter
zone 127.IN-ADDR.ARPA/IN: starting load
zone 127.IN-ADDR.ARPA/IN: number of nodes in database: 0
zone 127.IN-ADDR.ARPA/IN: loaded
zone_settimer: zone 127.IN-ADDR.ARPA/IN: enter
zone 254.169.IN-ADDR.ARPA/IN: starting load
zone 254.169.IN-ADDR.ARPA/IN: number of nodes in database: 0
zone 254.169.IN-ADDR.ARPA/IN: loaded
zone_settimer: zone 254.169.IN-ADDR.ARPA/IN: enter
zone 2.0.192.IN-ADDR.ARPA/IN: starting load
zone 2.0.192.IN-ADDR.ARPA/IN: number of nodes in database: 0
zone 2.0.192.IN-ADDR.ARPA/IN: loaded
zone_settimer: zone 2.0.192.IN-ADDR.ARPA/IN: enter
zone 100.51.198.IN-ADDR.ARPA/IN: starting load
zone 100.51.198.IN-ADDR.ARPA/IN: number of nodes in database: 0
zone 100.51.198.IN-ADDR.ARPA/IN: loaded
zone_settimer: zone 100.51.198.IN-ADDR.ARPA/IN: enter
zone 113.0.203.IN-ADDR.ARPA/IN: starting load
zone 113.0.203.IN-ADDR.ARPA/IN: number of nodes in database: 0
zone 113.0.203.IN-ADDR.ARPA/IN: loaded
zone_settimer: zone 113.0.203.IN-ADDR.ARPA/IN: enter
zone 255.255.255.255.IN-ADDR.ARPA/IN: starting load
zone 255.255.255.255.IN-ADDR.ARPA/IN: number of nodes in database: 0
zone 255.255.255.255.IN-ADDR.ARPA/IN: loaded
zone_settimer: zone 255.255.255.255.IN-ADDR.ARPA/IN: enter
zone 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: starting load
zone 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: number of nodes in database: 0
zone 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: loaded
zone_settimer: zone 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
zone 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: starting load
zone 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: number of nodes in database: 0
zone 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: loaded
zone_settimer: zone 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
zone 8.B.D.0.1.0.0.2.IP6.ARPA/IN: starting load
zone 8.B.D.0.1.0.0.2.IP6.ARPA/IN: number of nodes in database: 0
zone 8.B.D.0.1.0.0.2.IP6.ARPA/IN: loaded
zone_settimer: zone 8.B.D.0.1.0.0.2.IP6.ARPA/IN: enter
zone D.F.IP6.ARPA/IN: starting load
zone D.F.IP6.ARPA/IN: number of nodes in database: 0
zone D.F.IP6.ARPA/IN: loaded
zone_settimer: zone D.F.IP6.ARPA/IN: enter
zone 8.E.F.IP6.ARPA/IN: starting load
zone 8.E.F.IP6.ARPA/IN: number of nodes in database: 0
zone 8.E.F.IP6.ARPA/IN: loaded
zone_settimer: zone 8.E.F.IP6.ARPA/IN: enter
zone 9.E.F.IP6.ARPA/IN: starting load
zone 9.E.F.IP6.ARPA/IN: number of nodes in database: 0
zone 9.E.F.IP6.ARPA/IN: loaded
zone_settimer: zone 9.E.F.IP6.ARPA/IN: enter
zone A.E.F.IP6.ARPA/IN: starting load
zone A.E.F.IP6.ARPA/IN: number of nodes in database: 0
zone A.E.F.IP6.ARPA/IN: loaded
zone_settimer: zone A.E.F.IP6.ARPA/IN: enter
zone B.E.F.IP6.ARPA/IN: starting load
zone B.E.F.IP6.ARPA/IN: number of nodes in database: 0
zone B.E.F.IP6.ARPA/IN: loaded
zone_settimer: zone B.E.F.IP6.ARPA/IN: enter
managed-keys-zone ./IN: starting load
managed-keys-zone ./IN: loading from master file managed-keys.bind failed: file not found
managed-keys-zone ./IN: number of nodes in database: 1
managed-keys-zone ./IN: creating SOA
no journal file, but that's OK
managed-keys-zone ./IN: journal rollforward completed successfully: no journal
managed-keys-zone ./IN: loaded
managed-keys-zone ./IN: synchronizing trusted keys
decrement_reference: delete from rbt: 0xb7e62fd8 .
zone_settimer: managed-keys-zone ./IN: enter
managed-keys-zone ./IN: loaded serial 0
zone authors.bind/CH: starting load
zone authors.bind/CH: number of nodes in database: 0
zone authors.bind/CH: loaded
zone_settimer: zone authors.bind/CH: enter
zone hostname.bind/CH: starting load
zone hostname.bind/CH: number of nodes in database: 0
zone hostname.bind/CH: loaded
zone_settimer: zone hostname.bind/CH: enter
zone version.bind/CH: starting load
zone version.bind/CH: number of nodes in database: 0
zone version.bind/CH: loaded
zone_settimer: zone version.bind/CH: enter
zone id.server/CH: starting load
zone id.server/CH: number of nodes in database: 0
zone id.server/CH: loaded
zone_settimer: zone id.server/CH: enter
dns_zone_maintenance: managed-keys-zone ./IN: enter
zone_settimer: managed-keys-zone ./IN: enter
dns_zone_maintenance: zone 0.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 0.IN-ADDR.ARPA/IN: enter
dns_zone_maintenance: zone 127.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 127.IN-ADDR.ARPA/IN: enter
dns_zone_maintenance: zone 254.169.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 254.169.IN-ADDR.ARPA/IN: enter
dns_zone_maintenance: zone 2.0.192.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 2.0.192.IN-ADDR.ARPA/IN: enter
dns_zone_maintenance: zone 100.51.198.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 100.51.198.IN-ADDR.ARPA/IN: enter
dns_zone_maintenance: zone 113.0.203.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 113.0.203.IN-ADDR.ARPA/IN: enter
dns_zone_maintenance: zone 255.255.255.255.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 255.255.255.255.IN-ADDR.ARPA/IN: enter
dns_zone_maintenance: zone 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
zone_settimer: zone 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
dns_zone_maintenance: zone 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
zone_settimer: zone 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
dns_zone_maintenance: zone D.F.IP6.ARPA/IN: enter
zone_settimer: zone D.F.IP6.ARPA/IN: enter
dns_zone_maintenance: zone 8.E.F.IP6.ARPA/IN: enter
zone_settimer: zone 8.E.F.IP6.ARPA/IN: enter
dns_zone_maintenance: zone 9.E.F.IP6.ARPA/IN: enter
zone_settimer: zone 9.E.F.IP6.ARPA/IN: enter
dns_zone_maintenance: zone A.E.F.IP6.ARPA/IN: enter
zone_settimer: zone A.E.F.IP6.ARPA/IN: enter
dns_zone_maintenance: zone B.E.F.IP6.ARPA/IN: enter
zone_settimer: zone B.E.F.IP6.ARPA/IN: enter
dns_zone_maintenance: zone 8.B.D.0.1.0.0.2.IP6.ARPA/IN: enter
zone_settimer: zone 8.B.D.0.1.0.0.2.IP6.ARPA/IN: enter
dns_zone_maintenance: zone version.bind/CH: enter
zone_settimer: zone version.bind/CH: enter
dns_zone_maintenance: zone hostname.bind/CH: enter
zone_settimer: zone hostname.bind/CH: enter
dns_zone_maintenance: zone authors.bind/CH: enter
zone_settimer: zone authors.bind/CH: enter
dns_zone_maintenance: zone id.server/CH: enter
zone_settimer: zone id.server/CH: enter
running
client @0xb7f8f008: udprecv
client @0xb7f8f3f8: accept
client @0xb7f8f7e8: udprecv
client @0xb7f8fbd8: accept
zone_timer: zone 0.IN-ADDR.ARPA/IN: enter
zone_maintenance: zone 0.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 0.IN-ADDR.ARPA/IN: enter
zone_timer: zone 254.169.IN-ADDR.ARPA/IN: enter
zone_maintenance: zone 254.169.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 254.169.IN-ADDR.ARPA/IN: enter
zone_timer: zone 127.IN-ADDR.ARPA/IN: enter
zone_maintenance: zone 127.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 127.IN-ADDR.ARPA/IN: enter
zone_timer: zone B.E.F.IP6.ARPA/IN: enter
zone_maintenance: zone B.E.F.IP6.ARPA/IN: enter
zone_settimer: zone B.E.F.IP6.ARPA/IN: enter
zone_timer: zone 2.0.192.IN-ADDR.ARPA/IN: enter
zone_maintenance: zone 2.0.192.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 2.0.192.IN-ADDR.ARPA/IN: enter
zone_timer: zone 113.0.203.IN-ADDR.ARPA/IN: enter
zone_maintenance: zone 113.0.203.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 113.0.203.IN-ADDR.ARPA/IN: enter
zone_timer: zone 100.51.198.IN-ADDR.ARPA/IN: enter
zone_maintenance: zone 100.51.198.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 100.51.198.IN-ADDR.ARPA/IN: enter
zone_timer: zone 255.255.255.255.IN-ADDR.ARPA/IN: enter
zone_maintenance: zone 255.255.255.255.IN-ADDR.ARPA/IN: enter
zone_settimer: zone 255.255.255.255.IN-ADDR.ARPA/IN: enter
zone_timer: zone id.server/CH: enter
zone_maintenance: zone id.server/CH: enter
zone_settimer: zone id.server/CH: enter
zone_timer: zone 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
zone_maintenance: zone 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
zone_settimer: zone 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
zone_timer: zone 8.E.F.IP6.ARPA/IN: enter
zone_maintenance: zone 8.E.F.IP6.ARPA/IN: enter
zone_settimer: zone 8.E.F.IP6.ARPA/IN: enter
zone_timer: zone D.F.IP6.ARPA/IN: enter
zone_maintenance: zone D.F.IP6.ARPA/IN: enter
zone_settimer: zone D.F.IP6.ARPA/IN: enter
zone_timer: zone version.bind/CH: enter
zone_maintenance: zone version.bind/CH: enter
zone_settimer: zone version.bind/CH: enter
zone_timer: zone 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
zone_maintenance: zone 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
zone_settimer: zone 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: enter
zone_timer: zone 9.E.F.IP6.ARPA/IN: enter
zone_maintenance: zone 9.E.F.IP6.ARPA/IN: enter
zone_settimer: zone 9.E.F.IP6.ARPA/IN: enter
zone_timer: zone hostname.bind/CH: enter
zone_maintenance: zone hostname.bind/CH: enter
zone_settimer: zone hostname.bind/CH: enter
zone_timer: zone authors.bind/CH: enter
zone_maintenance: zone authors.bind/CH: enter
zone_settimer: zone authors.bind/CH: enter
zone_timer: zone A.E.F.IP6.ARPA/IN: enter
zone_maintenance: zone A.E.F.IP6.ARPA/IN: enter
zone_settimer: zone A.E.F.IP6.ARPA/IN: enter
zone_timer: zone 8.B.D.0.1.0.0.2.IP6.ARPA/IN: enter
zone_maintenance: zone 8.B.D.0.1.0.0.2.IP6.ARPA/IN: enter
zone_settimer: zone 8.B.D.0.1.0.0.2.IP6.ARPA/IN: enter
client 127.0.0.1#39039: UDP request
client 127.0.0.1#39039: request is not signed
client 127.0.0.1#39039: recursion available
client 127.0.0.1#39039: query
client 127.0.0.1#39039: query: exanames.de IN A +ED (127.0.0.1)
client 127.0.0.1#39039: query (cache) 'exanames.de/A/IN' approved
client 127.0.0.1#39039: replace
clientmgr @0xb7f603c8: createclients
clientmgr @0xb7f603c8: create new
client @0xb7e65008: create
createfetch: exanames.de A
fctx 0xb7e66008(exanames.de/A'): create
fctx 0xb7e66008(exanames.de/A'): join
fetch 0xb7f6d178 (fctx 0xb7e66008(exanames.de/A)): created
client @0xb7e65008: udprecv
fctx 0xb7e66008(exanames.de/A'): start
fctx 0xb7e66008(exanames.de/A'): try
fctx 0xb7e66008(exanames.de/A'): cancelqueries
fctx 0xb7e66008(exanames.de/A'): getaddresses
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: priming
createfetch: . NS
fctx 0xb7e66278(./NS'): create
fctx 0xb7e66278(./NS'): join
fetch 0xb7f6d1e8 (fctx 0xb7e66278(./NS)): created
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
res 0xb7f620c0: dns_resolver_prime
fctx 0xb7e66008(exanames.de/A'): query
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): send
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): sent
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): udpconnected
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): senddone
fctx 0xb7e66278(./NS'): start
fctx 0xb7e66278(./NS'): try
fctx 0xb7e66278(./NS'): cancelqueries
fctx 0xb7e66278(./NS'): getaddresses
fctx 0xb7e66278(./NS'): query
resquery 0xb7e68280 (fctx 0xb7e66278(./NS)): send
resquery 0xb7e68280 (fctx 0xb7e66278(./NS)): sent
resquery 0xb7e68280 (fctx 0xb7e66278(./NS)): udpconnected
resquery 0xb7e68280 (fctx 0xb7e66278(./NS)): senddone
resquery 0xb7e68280 (fctx 0xb7e66278(./NS)): response
fctx 0xb7e66278(./NS'): answer_response
fctx 0xb7e66278(./NS'): cache_message
decrement_reference: delete from rbt: 0xb7f26008 .
decrement_reference: delete from rbt: 0xb7f27008 g.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 m.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 j.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 f.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 i.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 e.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 l.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 a.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 b.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 d.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 h.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 k.root-servers.net
decrement_reference: delete from rbt: 0xb7f27008 c.root-servers.net
fctx 0xb7e66278(./NS'): cancelquery
fctx 0xb7e66278(./NS'): wait for validator
fctx 0xb7e66278(./NS'): cancelqueries
validating @0x82b9db8: . NS: starting
validating @0x82b9db8: . NS: attempting positive response validation
createfetch: . DNSKEY
fctx 0xb7e664e8(./DNSKEY'): create
fctx 0xb7e664e8(./DNSKEY'): join
fetch 0xb7f6d1c8 (fctx 0xb7e664e8(./DNSKEY)): created
fctx 0xb7e664e8(./DNSKEY'): start
fctx 0xb7e664e8(./DNSKEY'): try
fctx 0xb7e664e8(./DNSKEY'): cancelqueries
fctx 0xb7e664e8(./DNSKEY'): getaddresses
fctx 0xb7e664e8(./DNSKEY'): query
resquery 0xb7e68280 (fctx 0xb7e664e8(./DNSKEY)): send
resquery 0xb7e68280 (fctx 0xb7e664e8(./DNSKEY)): sent
resquery 0xb7e68280 (fctx 0xb7e664e8(./DNSKEY)): udpconnected
resquery 0xb7e68280 (fctx 0xb7e664e8(./DNSKEY)): senddone
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): response
fctx 0xb7e66008(exanames.de/A'): noanswer_response
fctx 0xb7e66008(exanames.de/A'): cache_message
fctx 0xb7e66008(exanames.de/A'): cancelquery
fctx 0xb7e66008(exanames.de/A'): cancelqueries
fctx 0xb7e66008(exanames.de/A'): try
fctx 0xb7e66008(exanames.de/A'): cancelqueries
fctx 0xb7e66008(exanames.de/A'): getaddresses
fctx 0xb7e66008(exanames.de/A'): query
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): send
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): sent
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): udpconnected
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): senddone
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): response
fctx 0xb7e66008(exanames.de/A'): noanswer_response
fctx 0xb7e66008(exanames.de/A'): cache_message
fctx 0xb7e66008(exanames.de/A'): cancelquery
fctx 0xb7e66008(exanames.de/A'): cancelqueries
fctx 0xb7e66008(exanames.de/A'): try
fctx 0xb7e66008(exanames.de/A'): cancelqueries
fctx 0xb7e66008(exanames.de/A'): getaddresses
createfetch: a.hosteddnsservice.com A
fctx 0xb7e66758(a.hosteddnsservice.com/A'): create
fctx 0xb7e66758(a.hosteddnsservice.com/A'): join
fetch 0xb7f6d1d8 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): created
createfetch: a.hosteddnsservice.com AAAA
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): create
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): join
fetch 0xb7f6d1a8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): created
createfetch: b.hosteddnsservice.com A
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): create
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): join
fetch 0xb7f6d180 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): created
createfetch: b.hosteddnsservice.com AAAA
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): create
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): join
fetch 0xb7f6d188 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): created
fctx 0xb7e66008(exanames.de/A'): addrwait
fctx 0xb7e66758(a.hosteddnsservice.com/A'): start
fctx 0xb7e66758(a.hosteddnsservice.com/A'): try
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66758(a.hosteddnsservice.com/A'): getaddresses
fctx 0xb7e66758(a.hosteddnsservice.com/A'): query
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): send
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): sent
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): start
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): try
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): getaddresses
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): query
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): send
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): sent
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): udpconnected
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): senddone
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): udpconnected
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): start
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): try
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): getaddresses
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): query
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): send
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): sent
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): start
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): try
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): getaddresses
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): query
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): send
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): sent
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): udpconnected
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): senddone
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): udpconnected
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): senddone
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): senddone
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): response
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): noanswer_response
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cache_message
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cancelquery
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): try
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): getaddresses
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): query
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): send
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): sent
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): udpconnected
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): senddone
resquery 0xb7e68280 (fctx 0xb7e664e8(./DNSKEY)): response
fctx 0xb7e664e8(./DNSKEY'): answer_response
fctx 0xb7e664e8(./DNSKEY'): cache_message
fctx 0xb7e664e8(./DNSKEY'): cancelquery
fctx 0xb7e664e8(./DNSKEY'): wait for validator
fctx 0xb7e664e8(./DNSKEY'): cancelqueries
validating @0x837dc58: . DNSKEY: starting
validating @0x837dc58: . DNSKEY: attempting positive response validation
validating @0x837dc58: . DNSKEY: verify rdataset (keyid=19036): success
validating @0x837dc58: . DNSKEY: signed by trusted key; marking as secure
fctx 0xb7e664e8(./DNSKEY'): received validation completion event
validator @0x837dc58: dns_validator_destroy
fctx 0xb7e664e8(./DNSKEY'): validation OK
fctx 0xb7e664e8(./DNSKEY'): clone_results
fctx 0xb7e664e8(./DNSKEY'): done
fctx 0xb7e664e8(./DNSKEY'): stopeverything
fctx 0xb7e664e8(./DNSKEY'): cancelqueries
fctx 0xb7e664e8(./DNSKEY'): sendevents
fetch 0xb7f6d1c8 (fctx 0xb7e664e8(./DNSKEY)): destroyfetch
fctx 0xb7e664e8(./DNSKEY'): shutdown
validating @0x82b9db8: . NS: in fetch_callback_validator
validating @0x82b9db8: . NS: keyset with trust 8
validating @0x82b9db8: . NS: resuming validate
validating @0x82b9db8: . NS: verify rdataset (keyid=34525): success
validating @0x82b9db8: . NS: marking as secure, noqname proof not needed
fctx 0xb7e664e8(./DNSKEY'): doshutdown
fctx 0xb7e664e8(./DNSKEY'): stopeverything
fctx 0xb7e664e8(./DNSKEY'): cancelqueries
fctx 0xb7e664e8(./DNSKEY'): destroy
fctx 0xb7e66278(./NS'): received validation completion event
validator @0x82b9db8: dns_validator_destroy
fctx 0xb7e66278(./NS'): validation OK
fctx 0xb7e66278(./NS'): clone_results
fctx 0xb7e66278(./NS'): done
fctx 0xb7e66278(./NS'): stopeverything
fctx 0xb7e66278(./NS'): cancelqueries
fctx 0xb7e66278(./NS'): sendevents
fetch 0xb7f6d1e8 (fctx 0xb7e66278(./NS)): destroyfetch
fctx 0xb7e66278(./NS'): shutdown
fctx 0xb7e66278(./NS'): doshutdown
fctx 0xb7e66278(./NS'): stopeverything
fctx 0xb7e66278(./NS'): cancelqueries
fctx 0xb7e66278(./NS'): destroy
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): response
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): noanswer_response
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cache_message
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cancelquery
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): try
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): getaddresses
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): query
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): send
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): sent
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): udpconnected
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): senddone
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): response
fctx 0xb7e66758(a.hosteddnsservice.com/A'): noanswer_response
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cache_message
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cancelquery
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66758(a.hosteddnsservice.com/A'): try
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66758(a.hosteddnsservice.com/A'): getaddresses
fctx 0xb7e66758(a.hosteddnsservice.com/A'): query
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): send
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): sent
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): udpconnected
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): senddone
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): response
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): noanswer_response
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cache_message
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cancelquery
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): try
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): getaddresses
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): query
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): send
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): sent
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): udpconnected
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): senddone
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): response
fctx 0xb7e66758(a.hosteddnsservice.com/A'): noanswer_response
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cache_message
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cancelquery
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66758(a.hosteddnsservice.com/A'): try
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66758(a.hosteddnsservice.com/A'): getaddresses
fctx 0xb7e66758(a.hosteddnsservice.com/A'): query
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): send
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): sent
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): udpconnected
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): senddone
resquery 0xb7e68008 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): response
fctx 0xb7e66758(a.hosteddnsservice.com/A'): answer_response
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cache_message
fctx 0xb7e66758(a.hosteddnsservice.com/A'): clone_results
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cancelquery
fctx 0xb7e66758(a.hosteddnsservice.com/A'): done
fctx 0xb7e66758(a.hosteddnsservice.com/A'): stopeverything
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66758(a.hosteddnsservice.com/A'): sendevents
fetch 0xb7f6d1d8 (fctx 0xb7e66758(a.hosteddnsservice.com/A)): destroyfetch
fctx 0xb7e66758(a.hosteddnsservice.com/A'): shutdown
DNS_EVENT_ADBMOREADDRESSES
fctx 0xb7e66758(a.hosteddnsservice.com/A'): doshutdown
fctx 0xb7e66758(a.hosteddnsservice.com/A'): stopeverything
fctx 0xb7e66758(a.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66758(a.hosteddnsservice.com/A'): destroy
fctx 0xb7e66008(exanames.de/A'): finddone
fctx 0xb7e66008(exanames.de/A'): try
fctx 0xb7e66008(exanames.de/A'): cancelqueries
fctx 0xb7e66008(exanames.de/A'): getaddresses
fctx 0xb7e66008(exanames.de/A'): query
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): send
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): sent
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): udpconnected
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): senddone
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): response
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): noanswer_response
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cache_message
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cancelquery
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): try
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): getaddresses
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): query
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): send
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): sent
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): udpconnected
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): senddone
resquery 0xb7e68008 (fctx 0xb7e66008(exanames.de/A)): response
fctx 0xb7e66008(exanames.de/A'): answer_response
fctx 0xb7e66008(exanames.de/A'): cache_message
fctx 0xb7e66008(exanames.de/A'): cancelquery
fctx 0xb7e66008(exanames.de/A'): wait for validator
fctx 0xb7e66008(exanames.de/A'): cancelqueries
validating @0x837dc58: exanames.de A: starting
validating @0x837dc58: exanames.de A: attempting positive response validation
createfetch: exanames.de DNSKEY
fctx 0xb7e66758(exanames.de/DNSKEY'): create
fctx 0xb7e66758(exanames.de/DNSKEY'): join
fetch 0xb7f6d1d8 (fctx 0xb7e66758(exanames.de/DNSKEY)): created
fctx 0xb7e66758(exanames.de/DNSKEY'): start
fctx 0xb7e66758(exanames.de/DNSKEY'): try
fctx 0xb7e66758(exanames.de/DNSKEY'): cancelqueries
fctx 0xb7e66758(exanames.de/DNSKEY'): getaddresses
fctx 0xb7e66758(exanames.de/DNSKEY'): query
resquery 0xb7e68008 (fctx 0xb7e66758(exanames.de/DNSKEY)): send
resquery 0xb7e68008 (fctx 0xb7e66758(exanames.de/DNSKEY)): sent
resquery 0xb7e68008 (fctx 0xb7e66758(exanames.de/DNSKEY)): udpconnected
resquery 0xb7e68008 (fctx 0xb7e66758(exanames.de/DNSKEY)): senddone
resquery 0xb7e689e8 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): response
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): noanswer_response
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): ncache_message
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): clone_results
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cancelquery
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): done
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): stopeverything
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): sendevents
fetch 0xb7f6d188 (fctx 0xb7e72008(b.hosteddnsservice.com/AAAA)): destroyfetch
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): shutdown
DNS_EVENT_ADBNOMOREADDRESSES
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): doshutdown
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): stopeverything
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e72008(b.hosteddnsservice.com/AAAA'): destroy
resquery 0xb7e68008 (fctx 0xb7e66758(exanames.de/DNSKEY)): response
fctx 0xb7e66758(exanames.de/DNSKEY'): answer_response
fctx 0xb7e66758(exanames.de/DNSKEY'): cache_message
fctx 0xb7e66758(exanames.de/DNSKEY'): cancelquery
fctx 0xb7e66758(exanames.de/DNSKEY'): wait for validator
fctx 0xb7e66758(exanames.de/DNSKEY'): cancelqueries
validating @0x82b8db0: exanames.de DNSKEY: starting
validating @0x82b8db0: exanames.de DNSKEY: attempting positive response validation
createfetch: exanames.de DS
fctx 0xb7e72008(exanames.de/DS'): create
fctx 0xb7e72008(exanames.de/DS'): join
fetch 0xb7f6d198 (fctx 0xb7e72008(exanames.de/DS)): created
fctx 0xb7e72008(exanames.de/DS'): start
fctx 0xb7e72008(exanames.de/DS'): try
fctx 0xb7e72008(exanames.de/DS'): cancelqueries
fctx 0xb7e72008(exanames.de/DS'): getaddresses
fctx 0xb7e72008(exanames.de/DS'): query
resquery 0xb7e68008 (fctx 0xb7e72008(exanames.de/DS)): send
resquery 0xb7e68008 (fctx 0xb7e72008(exanames.de/DS)): sent
resquery 0xb7e68008 (fctx 0xb7e72008(exanames.de/DS)): udpconnected
resquery 0xb7e68008 (fctx 0xb7e72008(exanames.de/DS)): senddone
resquery 0xb7e68008 (fctx 0xb7e72008(exanames.de/DS)): response
fctx 0xb7e72008(exanames.de/DS'): answer_response
fctx 0xb7e72008(exanames.de/DS'): cache_message
fctx 0xb7e72008(exanames.de/DS'): cancelquery
fctx 0xb7e72008(exanames.de/DS'): wait for validator
fctx 0xb7e72008(exanames.de/DS'): cancelqueries
validating @0x82b9818: exanames.de DS: starting
validating @0x82b9818: exanames.de DS: attempting positive response validation
createfetch: de DNSKEY
fctx 0xb7e66278(de/DNSKEY'): create
fctx 0xb7e66278(de/DNSKEY'): join
fetch 0xb7f6d1e8 (fctx 0xb7e66278(de/DNSKEY)): created
fctx 0xb7e66278(de/DNSKEY'): start
fctx 0xb7e66278(de/DNSKEY'): try
fctx 0xb7e66278(de/DNSKEY'): cancelqueries
fctx 0xb7e66278(de/DNSKEY'): getaddresses
fctx 0xb7e66278(de/DNSKEY'): query
resquery 0xb7e68008 (fctx 0xb7e66278(de/DNSKEY)): send
resquery 0xb7e68008 (fctx 0xb7e66278(de/DNSKEY)): sent
resquery 0xb7e68008 (fctx 0xb7e66278(de/DNSKEY)): udpconnected
resquery 0xb7e68008 (fctx 0xb7e66278(de/DNSKEY)): senddone
resquery 0xb7e68008 (fctx 0xb7e66278(de/DNSKEY)): response
fctx 0xb7e66278(de/DNSKEY'): noanswer_response
fctx 0xb7e66278(de/DNSKEY'): ncache_message
fctx 0xb7e66278(de/DNSKEY'): cancelquery
fctx 0xb7e66278(de/DNSKEY'): wait for validator
fctx 0xb7e66278(de/DNSKEY'): cancelqueries
validating @0x82ba280: de DNSKEY: starting
validating @0x82ba280: de DNSKEY: attempting negative response validation
validating @0x82ba280: de DNSKEY: nonexistence proof(s) not found
validating @0x82ba280: de DNSKEY: checking existence of DS at 'de'
createfetch: de DS
fctx 0xb7e664e8(de/DS'): create
fctx 0xb7e664e8(de/DS'): join
fetch 0xb7f6d1c8 (fctx 0xb7e664e8(de/DS)): created
fctx 0xb7e664e8(de/DS'): start
fctx 0xb7e664e8(de/DS'): try
fctx 0xb7e664e8(de/DS'): cancelqueries
fctx 0xb7e664e8(de/DS'): getaddresses
fctx 0xb7e664e8(de/DS'): query
resquery 0xb7e68008 (fctx 0xb7e664e8(de/DS)): send
resquery 0xb7e68008 (fctx 0xb7e664e8(de/DS)): sent
resquery 0xb7e68008 (fctx 0xb7e664e8(de/DS)): udpconnected
resquery 0xb7e68008 (fctx 0xb7e664e8(de/DS)): senddone
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): response
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): noanswer_response
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cache_message
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cancelquery
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): try
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): getaddresses
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): query
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): send
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): sent
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): udpconnected
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): senddone
resquery 0xb7e68770 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): response
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): answer_response
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cache_message
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): clone_results
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cancelquery
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): done
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): stopeverything
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): sendevents
fetch 0xb7f6d180 (fctx 0xb7e66c38(b.hosteddnsservice.com/A)): destroyfetch
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): shutdown
DNS_EVENT_ADBMOREADDRESSES
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): doshutdown
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): stopeverything
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): cancelqueries
fctx 0xb7e66c38(b.hosteddnsservice.com/A'): destroy
fctx 0xb7e66008(exanames.de/A'): finddone
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): response
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): noanswer_response
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cache_message
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cancelquery
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): try
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): getaddresses
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): query
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): send
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): sent
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): udpconnected
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): senddone
resquery 0xb7e684f8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): response
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): answer_response
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cache_message
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): clone_results
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cancelquery
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): done
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): stopeverything
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): sendevents
fetch 0xb7f6d1a8 (fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA)): destroyfetch
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): shutdown
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): doshutdown
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): stopeverything
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): cancelqueries
fctx 0xb7e669c8(a.hosteddnsservice.com/AAAA'): destroy
resquery 0xb7e68008 (fctx 0xb7e664e8(de/DS)): response
fctx 0xb7e664e8(de/DS'): noanswer_response
fctx 0xb7e664e8(de/DS'): ncache_message
fctx 0xb7e664e8(de/DS'): cancelquery
fctx 0xb7e664e8(de/DS'): wait for validator
fctx 0xb7e664e8(de/DS'): cancelqueries
validating @0x8373c08: de DS: starting
validating @0x8373c08: de DS: attempting negative response validation
  validating @0x8374670: . SOA: starting
  validating @0x8374670: . SOA: attempting positive response validation
  validating @0x8374670: . SOA: keyset with trust 8
  validating @0x8374670: . SOA: verify rdataset (keyid=34525): success
  validating @0x8374670: . SOA: marking as secure, noqname proof not needed
  validator @0x8374670: dns_validator_destroy
validating @0x8373c08: de DS: in authvalidated
validating @0x8373c08: de DS: resuming nsecvalidate
  validating @0x8374670: de NSEC: starting
  validating @0x8374670: de NSEC: attempting positive response validation
  validating @0x8374670: de NSEC: keyset with trust 8
  validating @0x8374670: de NSEC: verify rdataset (keyid=34525): success
  validating @0x8374670: de NSEC: marking as secure, noqname proof not needed
  validator @0x8374670: dns_validator_destroy
validating @0x8373c08: de DS: in authvalidated
validating @0x8373c08: de DS: looking for relevant nsec
validating @0x8373c08: de DS: nsec proves name exists (owner) data=0
validating @0x8373c08: de DS: resuming nsecvalidate
validating @0x8373c08: de DS: nonexistence proof(s) found
fctx 0xb7e664e8(de/DS'): received validation completion event
validator @0x8373c08: dns_validator_destroy
fctx 0xb7e664e8(de/DS'): nonexistence validation OK
fctx 0xb7e664e8(de/DS'): clone_results
fctx 0xb7e664e8(de/DS'): done
fctx 0xb7e664e8(de/DS'): stopeverything
fctx 0xb7e664e8(de/DS'): cancelqueries
fctx 0xb7e664e8(de/DS'): sendevents
fetch 0xb7f6d1c8 (fctx 0xb7e664e8(de/DS)): destroyfetch
fctx 0xb7e664e8(de/DS'): shutdown
validating @0x82ba280: de DNSKEY: in dsfetched2: ncache nxrrset
validating @0x82ba280: de DNSKEY: marking as answer (dsfetched2)
fctx 0xb7e664e8(de/DS'): doshutdown
fctx 0xb7e664e8(de/DS'): stopeverything
fctx 0xb7e664e8(de/DS'): cancelqueries
fctx 0xb7e664e8(de/DS'): destroy
fctx 0xb7e66278(de/DNSKEY'): received validation completion event
validator @0x82ba280: dns_validator_destroy
fctx 0xb7e66278(de/DNSKEY'): nonexistence validation OK
fctx 0xb7e66278(de/DNSKEY'): clone_results
fctx 0xb7e66278(de/DNSKEY'): done
fctx 0xb7e66278(de/DNSKEY'): stopeverything
fctx 0xb7e66278(de/DNSKEY'): cancelqueries
fctx 0xb7e66278(de/DNSKEY'): sendevents
fetch 0xb7f6d1e8 (fctx 0xb7e66278(de/DNSKEY)): destroyfetch
fctx 0xb7e66278(de/DNSKEY'): shutdown
validating @0x82b9818: exanames.de DS: in fetch_callback_validator
validating @0x82b9818: exanames.de DS: fetch_callback_validator: got ncache nxrrset
fctx 0xb7e72008(exanames.de/DS'): received validation completion event
validator @0x82b9818: dns_validator_destroy
fctx 0xb7e72008(exanames.de/DS'): validation failed
fctx 0xb7e72008(exanames.de/DS'): add_bad
error (broken trust chain) resolving 'exanames.de/DS/IN': 81.91.164.5#53
fctx 0xb7e72008(exanames.de/DS'): done
fctx 0xb7e72008(exanames.de/DS'): stopeverything
fctx 0xb7e72008(exanames.de/DS'): cancelqueries
fctx 0xb7e72008(exanames.de/DS'): sendevents
fetch 0xb7f6d198 (fctx 0xb7e72008(exanames.de/DS)): destroyfetch
fctx 0xb7e72008(exanames.de/DS'): shutdown
validating @0x82b8db0: exanames.de DNSKEY: in dsfetched
validating @0x82b8db0: exanames.de DNSKEY: dsfetched: got broken trust chain
fctx 0xb7e72008(exanames.de/DS'): doshutdown
fctx 0xb7e72008(exanames.de/DS'): stopeverything
fctx 0xb7e72008(exanames.de/DS'): cancelqueries
fctx 0xb7e72008(exanames.de/DS'): destroy
fctx 0xb7e66758(exanames.de/DNSKEY'): received validation completion event
validator @0x82b8db0: dns_validator_destroy
fctx 0xb7e66758(exanames.de/DNSKEY'): validation failed
fctx 0xb7e66758(exanames.de/DNSKEY'): add_bad
error (broken trust chain) resolving 'exanames.de/DNSKEY/IN': 78.46.123.11#53
fctx 0xb7e66758(exanames.de/DNSKEY'): done
fctx 0xb7e66758(exanames.de/DNSKEY'): stopeverything
fctx 0xb7e66758(exanames.de/DNSKEY'): cancelqueries
fctx 0xb7e66758(exanames.de/DNSKEY'): sendevents
fctx 0xb7e66278(de/DNSKEY'): doshutdown
fctx 0xb7e66278(de/DNSKEY'): stopeverything
fctx 0xb7e66278(de/DNSKEY'): cancelqueries
fctx 0xb7e66278(de/DNSKEY'): destroy
fetch 0xb7f6d1d8 (fctx 0xb7e66758(exanames.de/DNSKEY)): destroyfetch
fctx 0xb7e66758(exanames.de/DNSKEY'): shutdown
validating @0x837dc58: exanames.de A: in fetch_callback_validator
validating @0x837dc58: exanames.de A: fetch_callback_validator: got broken trust chain
fctx 0xb7e66758(exanames.de/DNSKEY'): doshutdown
fctx 0xb7e66758(exanames.de/DNSKEY'): stopeverything
fctx 0xb7e66758(exanames.de/DNSKEY'): cancelqueries
fctx 0xb7e66758(exanames.de/DNSKEY'): destroy
fctx 0xb7e66008(exanames.de/A'): received validation completion event
validator @0x837dc58: dns_validator_destroy
fctx 0xb7e66008(exanames.de/A'): validation failed
fctx 0xb7e66008(exanames.de/A'): add_bad
error (broken trust chain) resolving 'exanames.de/A/IN': 83.169.21.25#53
fctx 0xb7e66008(exanames.de/A'): done
fctx 0xb7e66008(exanames.de/A'): stopeverything
fctx 0xb7e66008(exanames.de/A'): cancelqueries
fctx 0xb7e66008(exanames.de/A'): sendevents
client 127.0.0.1#39039: query failed (SERVFAIL) for exanames.de/IN/A at query.c:6193
client 127.0.0.1#39039: error
client 127.0.0.1#39039: send
client 127.0.0.1#39039: sendto
client 127.0.0.1#39039: senddone
client 127.0.0.1#39039: next
client 127.0.0.1#39039: endrequest
fetch completed at resolver.c:4157 for exanames.de/A in 0.403755: broken trust chain/broken trust chain [domain:exanames.de,referral:2,restart:2,qrysent:1,timeout:0,lame:0,neterr:0,badresp:0,adberr:0,findfail:0,valfail:1]
fetch 0xb7f6d178 (fctx 0xb7e66008(exanames.de/A)): destroyfetch
fctx 0xb7e66008(exanames.de/A'): shutdown
fctx 0xb7e66008(exanames.de/A'): doshutdown
fctx 0xb7e66008(exanames.de/A'): stopeverything
fctx 0xb7e66008(exanames.de/A'): cancelqueries
fctx 0xb7e66008(exanames.de/A'): destroy
shutting down
res 0xb7f620c0: shutdown
res 0xb7f620c0: exiting
dns_requestmgr_shutdown: 0xb7f99308
send_shutdown_events: 0xb7f99308
res 0xb7f62178: shutdown
res 0xb7f62178: exiting
dns_requestmgr_shutdown: 0xb7e5e128
send_shutdown_events: 0xb7e5e128
no longer listening on 127.0.0.1#1234
clientmgr @0xb7f603c8: destroy
no longer listening on 193.0.1.238#1234
clientmgr @0xb7f60518: destroy
zone_shutdown: zone 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: shutting down
zone_shutdown: zone 8.E.F.IP6.ARPA/IN: shutting down
zone_shutdown: zone 2.0.192.IN-ADDR.ARPA/IN: shutting down
zone_shutdown: zone 113.0.203.IN-ADDR.ARPA/IN: shutting down
zone_shutdown: zone 127.IN-ADDR.ARPA/IN: shutting down
zone_shutdown: zone B.E.F.IP6.ARPA/IN: shutting down
zone_shutdown: zone 255.255.255.255.IN-ADDR.ARPA/IN: shutting down
zone_shutdown: zone id.server/CH: shutting down
zone_shutdown: zone 100.51.198.IN-ADDR.ARPA/IN: shutting down
zone_shutdown: zone D.F.IP6.ARPA/IN: shutting down
zone_shutdown: zone authors.bind/CH: shutting down
zone_shutdown: zone 0.IN-ADDR.ARPA/IN: shutting down
zone_shutdown: zone 254.169.IN-ADDR.ARPA/IN: shutting down
client @0xb7f8f008: shutdown
client @0xb7f8f008: free
client @0xb7f8f3f8: shutdown
client @0xb7f8f3f8: accept failed: operation canceled
client @0xb7f8f3f8: free
client @0xb7f8f7e8: shutdown
client @0xb7f8f7e8: free
client @0xb7f8fbd8: shutdown
client @0xb7f8fbd8: accept failed: operation canceled
client @0xb7f8fbd8: free
clientmgr @0xb7f60518: clientmgr_destroy
client @0xb7e65008: shutdown
client @0xb7e65008: free
clientmgr @0xb7f603c8: clientmgr_destroy
zone_shutdown: managed-keys-zone ./IN: shutting down
calling free_rbtdb(.)
done free_rbtdb(.)
zone_shutdown: zone hostname.bind/CH: shutting down
zone_shutdown: zone 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA/IN: shutting down
zone_shutdown: zone 8.B.D.0.1.0.0.2.IP6.ARPA/IN: shutting down
zone_shutdown: zone version.bind/CH: shutting down
res 0xb7f62178: detach
res 0xb7f62178: destroy
dns_requestmgr_detach: 0xb7e5e128: eref 0 iref 0
mgr_destroy
calling free_rbtdb(.)
done free_rbtdb(.)
zone_shutdown: zone 9.E.F.IP6.ARPA/IN: shutting down
zone_shutdown: zone A.E.F.IP6.ARPA/IN: shutting down
res 0xb7f620c0: detach
res 0xb7f620c0: destroy
dns_requestmgr_detach: 0xb7f99308: eref 0 iref 0
mgr_destroy
calling free_rbtdb(.)
done free_rbtdb(.)
calling free_rbtdb(.)
done free_rbtdb(.)
exiting


More information about the dns-operations mailing list