[Pdns-dev] Is this a bug ?

Leen Besselink leen at wirehub.nl
Wed Feb 11 07:58:54 CET 2009


Hi,

An old version of PowerDNS-recursor and a djbdns all seam to return something like this (the same after a restart (I checked the djbdns)):

leen at ubuntu64:~$ dig @172.20.1.2 ad.doubleclick.net.

; <<>> DiG 9.5.0-P2 <<>> @172.20.1.2 ad.doubleclick.net.
; (1 server found)
;; global options:  printcmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 24890
;; flags: qr rd ra; QUERY: 1, ANSWER: 2, AUTHORITY: 0, ADDITIONAL: 0

;; QUESTION SECTION:
;ad.doubleclick.net.		IN	A

;; ANSWER SECTION:
ad.doubleclick.net.	900	IN	CNAME	ad.3ad.doubleclick.net.
ad.3ad.doubleclick.net.	30	IN	A	216.73.86.55

;; Query time: 249 msec
;; SERVER: 172.20.1.2#53(172.20.1.2)
;; WHEN: Wed Feb 11 00:26:37 2009
;; MSG SIZE  rcvd: 73

But the lastest powerdns-recursor (the pre-release with edns-ping enabled) returned this (the same after a restart):

leen at ubuntu64:~$ dig @172.20.1.1 ad.doubleclick.net.

; <<>> DiG 9.5.0-P2 <<>> @172.20.1.1 ad.doubleclick.net.
; (1 server found)
;; global options:  printcmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 45047
;; flags: qr rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 1, ADDITIONAL: 0

;; QUESTION SECTION:
;ad.doubleclick.net.		IN	A

;; ANSWER SECTION:
ad.doubleclick.net.	590	IN	CNAME	ad.3ad.doubleclick.net.

;; AUTHORITY SECTION:
3ad.doubleclick.net.	300	IN	SOA	eqva3dns1.doubleclick.net. hostmaster.doubleclick.net. 2005042901 86400 10800 604800 300

;; Query time: 205 msec
;; SERVER: 172.20.1.1#53(172.20.1.1)
;; WHEN: Wed Feb 11 00:41:53 2009
;; MSG SIZE  rcvd: 114

I don't really care about doubleclick.net, just noticed an ad did not load on a page because of DNS and got querious.
I have a pcap from the data send on the wire from the djbdns and the new powerdns-recursor.

And I took a look and found this difference in the last answer (tshark output):

Internet Protocol, Src: 74.125.242.85 (74.125.242.85), Dst: 82.75.6.35 (82.75.6.35)
    Version: 4
    Header length: 20 bytes
    Differentiated Services Field: 0x20 (DSCP 0x08: Class Selector 1; ECN: 0x00)
        0010 00.. = Differentiated Services Codepoint: Class Selector 1 (0x08)
        .... ..0. = ECN-Capable Transport (ECT): 0
        .... ...0 = ECN-CE: 0
    Total Length: 84
    Identification: 0xb2e1 (45793)
    Flags: 0x00
        0... = Reserved bit: Not set
        .0.. = Don't fragment: Not set
        ..0. = More fragments: Not set
    Fragment offset: 0
    Time to live: 50
    Protocol: UDP (0x11)
    Header checksum: 0x4057 [correct]
        [Good: True]
        [Bad : False]
    Source: 74.125.242.85 (74.125.242.85)
    Destination: 82.75.6.35 (82.75.6.35)
User Datagram Protocol, Src Port: 53 (53), Dst Port: 8409 (8409)
    Source port: 53 (53)
    Destination port: 8409 (8409)
    Length: 64
    Checksum: 0x5bf7 [correct]
        [Good Checksum: True]
        [Bad Checksum: False]
Domain Name System (response)
    [Request In: 7]
    [Time: 0.090158000 seconds]
    Transaction ID: 0xc8d8
    Flags: 0x8400 (Standard query response, No error)
        1... .... .... .... = Response: Message is a response
        .000 0... .... .... = Opcode: Standard query (0)
        .... .1.. .... .... = Authoritative: Server is an authority for domain
        .... ..0. .... .... = Truncated: Message is not truncated
        .... ...0 .... .... = Recursion desired: Don't do query recursively
        .... .... 0... .... = Recursion available: Server can't do recursive queries
        .... .... .0.. .... = Z: reserved (0)
        .... .... ..0. .... = Answer authenticated: Answer/authority portion was not authenticated by the server
        .... .... .... 0000 = Reply code: No error (0)
    Questions: 1
    Answer RRs: 1
    Authority RRs: 0
    Additional RRs: 0
    Queries
        ad.3ad.doubleclick.net: type A, class IN
            Name: ad.3ad.doubleclick.net
            Type: A (Host address)
            Class: IN (0x0001)
    Answers
        ad.3ad.doubleclick.net: type A, class IN, addr 209.62.176.153
            Name: ad.3ad.doubleclick.net
            Type: A (Host address)
            Class: IN (0x0001)
            Time to live: 30 seconds
            Data length: 4
            Addr: 209.62.176.153

Internet Protocol, Src: 209.62.176.151 (209.62.176.151), Dst: 172.20.1.1 (172.20.1.1)
    Version: 4
    Header length: 20 bytes
    Differentiated Services Field: 0x20 (DSCP 0x08: Class Selector 1; ECN: 0x00)
        0010 00.. = Differentiated Services Codepoint: Class Selector 1 (0x08)
        .... ..0. = ECN-Capable Transport (ECT): 0
        .... ...0 = ECN-CE: 0
    Total Length: 136
    Identification: 0xe916 (59670)
    Flags: 0x00
        0... = Reserved bit: Not set
        .0.. = Don't fragment: Not set
        ..0. = More fragments: Not set
    Fragment offset: 0
    Time to live: 51
    Protocol: UDP (0x11)
    Header checksum: 0x6f43 [correct]
        [Good: True]
        [Bad : False]
    Source: 209.62.176.151 (209.62.176.151)
    Destination: 172.20.1.1 (172.20.1.1)
User Datagram Protocol, Src Port: 53 (53), Dst Port: 62260 (62260)
    Source port: 53 (53)
    Destination port: 62260 (62260)
    Length: 116
    Checksum: 0x86a4 [correct]
        [Good Checksum: True]
        [Bad Checksum: False]
Domain Name System (response)
    [Request In: 9]
    [Time: 0.089181000 seconds]
    Transaction ID: 0xb0b8
    Flags: 0x8400 (Standard query response, No error)
        1... .... .... .... = Response: Message is a response
        .000 0... .... .... = Opcode: Standard query (0)
        .... .1.. .... .... = Authoritative: Server is an authority for domain
        .... ..0. .... .... = Truncated: Message is not truncated
        .... ...0 .... .... = Recursion desired: Don't do query recursively
        .... .... 0... .... = Recursion available: Server can't do recursive queries
        .... .... .0.. .... = Z: reserved (0)
        .... .... ..0. .... = Answer authenticated: Answer/authority portion was not authenticated by the server
        .... .... .... 0000 = Reply code: No error (0)
    Questions: 1
    Answer RRs: 0
    Authority RRs: 1
    Additional RRs: 1
    Queries
        ad.3ad.doubleclick.net: type A, class IN
            Name: ad.3ad.doubleclick.net
            Type: A (Host address)
            Class: IN (0x0001)
    Authoritative nameservers
        3ad.doubleclick.net: type SOA, class IN, mname eqnj3dns2.doubleclick.net
            Name: 3ad.doubleclick.net
            Type: SOA (Start of zone of authority)
            Class: IN (0x0001)
            Time to live: 5 minutes
            Data length: 45
            Primary name server: eqnj3dns2.doubleclick.net
            Responsible authority's mailbox: hostmaster.doubleclick.net
            Serial number: 2005051201
            Refresh interval: 1 day
            Retry interval: 3 hours
            Expiration limit: 7 days
            Minimum TTL: 5 minutes
    Additional records
        <Root>: type OPT
            Name: <Root>
            Type: OPT (EDNS0 option)
            UDP payload size: 4096
            Higher bits in extended RCODE: 0x0
            EDNS0 version: 0
            Z: 0x0
            Data length: 0

Here the trace from the logs:

Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] question for 'ad.doubleclick.net.|AAAA' from 172.20.1.10
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: Looking for CNAME cache hit of 'ad.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: No CNAME cache hit of 'ad.doubleclick.net.|CNAME' found
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: No cache hit for 'ad.doubleclick.net.|AAAA', trying to find an appropriate NS record
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: Checking if we have NS in cache for 'ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: no valid/useful NS in cache for 'ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: Checking if we have NS in cache for 'doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: NS (with ip, or non-glue) in cache for 'doubleclick.net.' -> 'ns1.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: within bailiwick: 1,  in cache, ttl=172541
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: NS (with ip, or non-glue) in cache for 'doubleclick.net.' -> 'ns2.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: within bailiwick: 1,  in cache, ttl=172541
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: NS (with ip, or non-glue) in cache for 'doubleclick.net.' -> 'ns3.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: within bailiwick: 1,  in cache, ttl=172541
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: NS (with ip, or non-glue) in cache for 'doubleclick.net.' -> 'ns4.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: within bailiwick: 1,  in cache, ttl=172541
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: We have NS in cache for 'doubleclick.net.' (flawedNSSet=0)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: Cache consultations done, have 4 NS to contact
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: Nameservers: ns1.doubleclick.net.(0ms), ns4.doubleclick.net.(0ms), ns3.doubleclick.net.(0ms),
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.:              ns2.doubleclick.net.(0ms)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: Trying to resolve NS 'ns1.doubleclick.net.' (1/4)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]   ns1.doubleclick.net.: Looking for CNAME cache hit of 'ns1.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]   ns1.doubleclick.net.: No CNAME cache hit of 'ns1.doubleclick.net.|CNAME' found
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]   ns1.doubleclick.net.: Found cache hit for A: 216.73.86.10[ttl=172541]
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: Resolved 'doubleclick.net.' NS ns1.doubleclick.net. to: 216.73.86.10
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: Trying IP 216.73.86.10:53, asking 'ad.doubleclick.net.|AAAA'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: Got 18 answers from ns1.doubleclick.net. (216.73.86.10), rcode=0, in 93ms
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer 'ad.doubleclick.net.|CNAME|ad.3ad.doubleclick.net.' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer '3ad.doubleclick.net.|NS|eqva3dns2.doubleclick.net.' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer '3ad.doubleclick.net.|NS|eqnj3dns1.doubleclick.net.' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer '3ad.doubleclick.net.|NS|eqnj3dns2.doubleclick.net.' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer '3ad.doubleclick.net.|NS|iad093dns1.doubleclick.net.' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer '3ad.doubleclick.net.|NS|iad093dns2.doubleclick.net.' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer '3ad.doubleclick.net.|NS|anny3dns1.doubleclick.net.' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer '3ad.doubleclick.net.|NS|anny3dns2.doubleclick.net.' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer '3ad.doubleclick.net.|NS|eqva3dns1.doubleclick.net.' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer 'eqva3dns2.doubleclick.net.|A|216.73.87.151' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer 'eqnj3dns1.doubleclick.net.|A|209.62.176.21' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer 'eqnj3dns2.doubleclick.net.|A|209.62.176.151' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer 'iad093dns1.doubleclick.net.|A|74.125.242.21' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer 'iad093dns2.doubleclick.net.|A|74.125.242.85' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer 'anny3dns1.doubleclick.net.|A|216.73.86.21' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer 'anny3dns2.doubleclick.net.|A|216.73.86.151' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: accept answer 'eqva3dns1.doubleclick.net.|A|216.73.87.21' from 'doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: skipping OPT answer '.' from 'doubleclick.net.' nameservers
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: determining status after receiving this packet
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] ad.doubleclick.net.: status=got a CNAME referral, starting over with ad.3ad.doubleclick.net.
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: Looking for CNAME cache hit of 'ad.3ad.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: No CNAME cache hit of 'ad.3ad.doubleclick.net.|CNAME' found
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: No cache hit for 'ad.3ad.doubleclick.net.|AAAA', trying to find an appropriate NS record
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: Checking if we have NS in cache for 'ad.3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: no valid/useful NS in cache for 'ad.3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: Checking if we have NS in cache for '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'anny3dns1.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'anny3dns2.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'eqnj3dns1.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'eqnj3dns2.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'eqva3dns1.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'eqva3dns2.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'iad093dns1.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'iad093dns2.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: We have NS in cache for '3ad.doubleclick.net.' (flawedNSSet=0)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: Cache consultations done, have 8 NS to contact
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: Nameservers: eqnj3dns2.doubleclick.net.(0ms), iad093dns2.doubleclick.net.(0ms), eqnj3dns1.doubleclick.net.(0ms),
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.:              anny3dns2.doubleclick.net.(0ms), anny3dns1.doubleclick.net.(0ms), eqva3dns2.doubleclick.net.(0ms),
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.:              iad093dns1.doubleclick.net.(0ms), eqva3dns1.doubleclick.net.(0ms)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: Trying to resolve NS 'eqnj3dns2.doubleclick.net.' (1/8)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]    eqnj3dns2.doubleclick.net.: Looking for CNAME cache hit of 'eqnj3dns2.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]    eqnj3dns2.doubleclick.net.: No CNAME cache hit of 'eqnj3dns2.doubleclick.net.|CNAME' found
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]    eqnj3dns2.doubleclick.net.: Found cache hit for A: 209.62.176.151[ttl=86400]
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: Resolved '3ad.doubleclick.net.' NS eqnj3dns2.doubleclick.net. to: 209.62.176.151
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: Trying IP 209.62.176.151:53, asking 'ad.3ad.doubleclick.net.|AAAA'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: Got 2 answers from eqnj3dns2.doubleclick.net. (209.62.176.151), rcode=0, in 94ms
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: accept answer '3ad.doubleclick.net.|SOA|eqnj3dns2.doubleclick.net. hostmaster.doubleclick.net. 2005051201 86400 10800 604800 300' from '3ad.doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: skipping OPT answer '.' from '3ad.doubleclick.net.' nameservers
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: determining status after receiving this packet
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: got negative caching indication for 'ad.3ad.doubleclick.net.|SOA'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885]  ad.3ad.doubleclick.net.: status=noerror, other types may exist, but we are done (have negative SOA)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [885] answer to question 'ad.doubleclick.net.|AAAA': 1 answers, 0 additional, took 2 packets, 0 throttled, 0 timeouts, 0 tcp connections, rcode=0
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886] question for 'ad.doubleclick.net.|A' from 172.20.1.10
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886] ad.doubleclick.net.: Looking for CNAME cache hit of 'ad.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886] ad.doubleclick.net.: Found cache CNAME hit for 'ad.doubleclick.net.|CNAME' to 'ad.3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Looking for CNAME cache hit of 'ad.3ad.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: No CNAME cache hit of 'ad.3ad.doubleclick.net.|CNAME' found
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: No cache hit for 'ad.3ad.doubleclick.net.|A', trying to find an appropriate NS record
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Checking if we have NS in cache for 'ad.3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: no valid/useful NS in cache for 'ad.3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Checking if we have NS in cache for '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'anny3dns1.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'anny3dns2.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'eqnj3dns1.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'eqnj3dns2.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'eqva3dns1.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'eqva3dns2.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'iad093dns1.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: NS (with ip, or non-glue) in cache for '3ad.doubleclick.net.' -> 'iad093dns2.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: within bailiwick: 0, not in cache / did not look at cache
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: We have NS in cache for '3ad.doubleclick.net.' (flawedNSSet=0)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Cache consultations done, have 8 NS to contact
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Nameservers: iad093dns1.doubleclick.net.(0ms), eqnj3dns1.doubleclick.net.(0ms), eqva3dns1.doubleclick.net.(0ms),
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.:              anny3dns2.doubleclick.net.(0ms), eqnj3dns2.doubleclick.net.(0ms), eqva3dns2.doubleclick.net.(0ms),
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.:              anny3dns1.doubleclick.net.(0ms), iad093dns2.doubleclick.net.(0ms)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Trying to resolve NS 'iad093dns1.doubleclick.net.' (1/8)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]    iad093dns1.doubleclick.net.: Looking for CNAME cache hit of 'iad093dns1.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]    iad093dns1.doubleclick.net.: No CNAME cache hit of 'iad093dns1.doubleclick.net.|CNAME' found
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]    iad093dns1.doubleclick.net.: Found cache hit for A: 74.125.242.21[ttl=3600]
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Resolved '3ad.doubleclick.net.' NS iad093dns1.doubleclick.net. to: 74.125.242.21
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Trying IP 74.125.242.21:53, asking 'ad.3ad.doubleclick.net.|A'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Got 14 answers from iad093dns1.doubleclick.net. (74.125.242.21), rcode=0, in 98ms
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|E.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|F.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|G.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|H.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|I.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|J.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|K.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|L.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|M.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|A.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|B.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|C.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '.|NS|D.ROOT-SERVERS.net.' from '3ad.doubleclick.net.' nameservers? NO!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: skipping OPT answer '.' from '3ad.doubleclick.net.' nameservers
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: determining status after receiving this packet
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'E.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'F.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'G.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'H.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'I.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'J.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'K.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'L.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'M.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'A.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'B.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'C.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got upwards/level NS record '.' -> 'D.ROOT-SERVERS.net.', had '3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: status=NS iad093dns1.doubleclick.net. (74.125.242.21) is lame for '3ad.doubleclick.net.', trying sibling IP or NS
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Trying to resolve NS 'eqnj3dns1.doubleclick.net.' (2/8)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]    eqnj3dns1.doubleclick.net.: Looking for CNAME cache hit of 'eqnj3dns1.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]    eqnj3dns1.doubleclick.net.: No CNAME cache hit of 'eqnj3dns1.doubleclick.net.|CNAME' found
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]    eqnj3dns1.doubleclick.net.: Found cache hit for A: 209.62.176.21[ttl=86400]
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Resolved '3ad.doubleclick.net.' NS eqnj3dns1.doubleclick.net. to: 209.62.176.21
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Trying IP 209.62.176.21:53, asking 'ad.3ad.doubleclick.net.|A'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: Got 2 answers from eqnj3dns1.doubleclick.net. (209.62.176.21), rcode=0, in 92ms
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: accept answer '3ad.doubleclick.net.|SOA|eqnj3dns2.doubleclick.net. hostmaster.doubleclick.net. 2005051201 86400 10800 604800 300' from '3ad.doubleclick.net.' nameservers? YES!
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: skipping OPT answer '.' from '3ad.doubleclick.net.' nameservers
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: determining status after receiving this packet
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: got negative caching indication for 'ad.3ad.doubleclick.net.|SOA'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886]  ad.3ad.doubleclick.net.: status=noerror, other types may exist, but we are done (have negative SOA)
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [886] answer to question 'ad.doubleclick.net.|A': 1 answers, 0 additional, took 2 packets, 0 throttled, 0 timeouts, 0 tcp connections, rcode=0
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [887] question for 'ad.doubleclick.net.|AAAA' from 172.20.1.10
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [887] ad.doubleclick.net.: Looking for CNAME cache hit of 'ad.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [887] ad.doubleclick.net.: Found cache CNAME hit for 'ad.doubleclick.net.|CNAME' to 'ad.3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [887]  ad.3ad.doubleclick.net.: Looking for CNAME cache hit of 'ad.3ad.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [887]  ad.3ad.doubleclick.net.: No CNAME cache hit of 'ad.3ad.doubleclick.net.|CNAME' found
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [887]  ad.3ad.doubleclick.net.: AAAA is negatively cached via '3ad.doubleclick.net.' for another 300 seconds
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [887]  3ad.doubleclick.net.: Found cache hit for SOA: eqnj3dns2.doubleclick.net. hostmaster.doubleclick.net. 2005051201 86400 10800 604800 300[ttl=300]
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [887] answer to question 'ad.doubleclick.net.|AAAA': 1 answers, 0 additional, took 0 packets, 0 throttled, 0 timeouts, 0 tcp connections, rcode=0
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [888] question for 'ad.doubleclick.net.|A' from 172.20.1.10
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [888] ad.doubleclick.net.: Looking for CNAME cache hit of 'ad.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [888] ad.doubleclick.net.: Found cache CNAME hit for 'ad.doubleclick.net.|CNAME' to 'ad.3ad.doubleclick.net.'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [888]  ad.3ad.doubleclick.net.: Looking for CNAME cache hit of 'ad.3ad.doubleclick.net.|CNAME'
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [888]  ad.3ad.doubleclick.net.: No CNAME cache hit of 'ad.3ad.doubleclick.net.|CNAME' found
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [888]  ad.3ad.doubleclick.net.: A is negatively cached via '3ad.doubleclick.net.' for another 300 seconds
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [888]  3ad.doubleclick.net.: Found cache hit for SOA: eqnj3dns2.doubleclick.net. hostmaster.doubleclick.net. 2005051201 86400 10800 604800 300[ttl=300]
Feb 11 00:20:43 debian64 pdns_recursor[3313]: [888] answer to question 'ad.doubleclick.net.|A': 1 answers, 0 additional, took 0 packets, 0 throttled, 0 timeouts, 0 tcp connections, rcode=0

Hope this was useful.

Have a nice day anyway,
	Leen Besselink.




More information about the Pdns-dev mailing list