Your message dated Tue, 21 Aug 2007 15:05:32 +0200
with message-id <[EMAIL PROTECTED]>
and subject line Bug#427516: Bad DNS hangs squid
has caused the attached Bug report to be marked as done.
This means that you claim that the problem has been dealt with.
If this is not the case it is now your responsibility to reopen the
Bug report if necessary, and/or fix the problem forthwith.
(NB: If you are a system administrator and have no idea what I am
talking about this indicates a serious mail system misconfiguration
somewhere. Please contact me immediately.)
Debian bug tracking system administrator
(administrator, Debian Bugs database)
--- Begin Message ---
Package: squid
Version: 2.6.5-6
Severity: grave
Justification: renders package unusable
Hi,
I'm not sure, but this could be quite a serious issue for any user of
squid out there, hence the grave setting.
It appears that etch squid hangs completely when fed bad DNS data- and
the only recovery is a full machine reboot.
Here is the relevant part of the log file (with squid debug turned on to
find the problem- this is the 4th time in 4 days):
2007/06/04 12:10:52| clientProcessRequest: GET
'http://cpacampaigns.directtrack.com/42/2631/8130'
2007/06/04 12:10:52| storeGet: looking up
78649369EDB1EC1103A78743E32E896B
2007/06/04 12:10:52| clientProcessRequest2: storeGet() MISS
2007/06/04 12:10:52| clientProcessRequest: TCP_MISS for
'http://cpacampaigns.directtrack.com/42/2631/8130'
2007/06/04 12:10:52| clientProcessMiss: 'GET
http://cpacampaigns.directtrack.com/42/2631/8130'
2007/06/04 12:10:52| storeCreateEntry:
'http://cpacampaigns.directtrack.com/42/2631/8130'
2007/06/04 12:10:52| creating rep: 0x8f82078
2007/06/04 12:10:52| init-ing hdr: 0x8f820b8 owner: 3
2007/06/04 12:10:52| 0x8f820b8 lookup for 38
2007/06/04 12:10:52| 0x8f820b8 lookup for 9
2007/06/04 12:10:52| 0x8f820b8 lookup for 38
2007/06/04 12:10:52| 0x8f820b8 lookup for 9
2007/06/04 12:10:52| 0x8f820b8 lookup for 22
2007/06/04 12:10:52| new_MemObject: returning 0x8f82930
2007/06/04 12:10:52| new_StoreEntry: returning 0x8501470
2007/06/04 12:10:52| storeKeyPrivate: GET
http://cpacampaigns.directtrack.com/42/2631/8130
2007/06/04 12:10:52| storeHashInsert: Inserting Entry 0x8501470 key
'02C887D62B71CA3E5B3AFAC3EE24F1CD'
2007/06/04 12:10:52| storeLockObject: key
'02C887D62B71CA3E5B3AFAC3EE24F1CD' count=2
2007/06/04 12:10:52| storeClientCopy: 02C887D62B71CA3E5B3AFAC3EE24F1CD,
seen 0, want 0, size 4096, cb 0x8069690, cbdata 0x86734d0
2007/06/04 12:10:52| cbdataLock: 0x86734d0
2007/06/04 12:10:52| cbdataLock: 0x858bef8
2007/06/04 12:10:52| storeClientCopy2: 02C887D62B71CA3E5B3AFAC3EE24F1CD
2007/06/04 12:10:52| storeClientCopy3: Waiting for more
2007/06/04 12:10:52| cbdataUnlock: 0x858bef8
2007/06/04 12:10:52| aclCheckFast: list: (nil)
2007/06/04 12:10:52| aclCheckFast: no matches, returning: 1
2007/06/04 12:10:52| fwdStart:
'http://cpacampaigns.directtrack.com/42/2631/8130'
2007/06/04 12:10:52| storeLockObject: key
'02C887D62B71CA3E5B3AFAC3EE24F1CD' count=3
2007/06/04 12:10:52| peerSelect:
http://cpacampaigns.directtrack.com/42/2631/8130
2007/06/04 12:10:52| storeLockObject: key
'02C887D62B71CA3E5B3AFAC3EE24F1CD' count=4
2007/06/04 12:10:52| cbdataLock: 0x88f91d0
2007/06/04 12:10:52| peerSelectFoo: 'GET cpacampaigns.directtrack.com'
2007/06/04 12:10:52| peerCheckNetdbDirect: MY RTT = 0 msec
2007/06/04 12:10:52| peerCheckNetdbDirect: minimum_direct_rtt = 400 msec
2007/06/04 12:10:52| peerCheckNetdbDirect: MY hops = 0
2007/06/04 12:10:52| peerCheckNetdbDirect: minimum_direct_hops = 4
2007/06/04 12:10:52| whichPeer: from 0.0.0.0 port 0
2007/06/04 12:10:52| peerSelectFoo: direct = DIRECT_MAYBE
2007/06/04 12:10:52| neighborsDigestSelect: choices: 0 (0)
2007/06/04 12:10:52| peerNoteDigestLookup: peer <none>, lookup:
LOOKUP_NONE
2007/06/04 12:10:52| peerSelectIcpPing:
http://cpacampaigns.directtrack.com/42/2631/8130
2007/06/04 12:10:52| neighborsCount: 0
2007/06/04 12:10:52| peerSelectIcpPing: counted 0 neighbors
2007/06/04 12:10:52| peerGetSomeParent: GET cpacampaigns.directtrack.com
2007/06/04 12:10:52| getDefaultParent: returning NULL
2007/06/04 12:10:52| peerSourceHashSelectParent: Calculating hash for
10.254.1.191
2007/06/04 12:10:52| getRoundRobinParent: returning NULL
2007/06/04 12:10:52| getFirstUpParent: returning NULL
2007/06/04 12:10:52| getAnyParent: returning NULL
2007/06/04 12:10:52| peerAddFwdServer: adding DIRECT DIRECT
2007/06/04 12:10:52| peerSelectCallback:
http://cpacampaigns.directtrack.com/42/2631/8130
2007/06/04 12:10:52| cbdataValid: 0x88f91d0
2007/06/04 12:10:52| fwdStartComplete:
http://cpacampaigns.directtrack.com/42/2631/8130
2007/06/04 12:10:52| fwdConnectStart:
http://cpacampaigns.directtrack.com/42/2631/8130
2007/06/04 12:10:52| fwdConnectStart: got addr 0.0.0.0, tos 0
2007/06/04 12:10:52| comm_open: FD 83 is a new socket
2007/06/04 12:10:52| fd_open FD 83
http://cpacampaigns.directtrack.com/42/2631/8130
2007/06/04 12:10:52| comm_add_close_handler: FD 83, handler=0x807bbb0,
data=0x88f91d0
2007/06/04 12:10:52| cbdataLock: 0x88f91d0
2007/06/04 12:10:52| commSetTimeout: FD 83 timeout 60
2007/06/04 12:10:52| commConnectStart: FD 83,
cpacampaigns.directtrack.com:80
2007/06/04 12:10:52| cbdataLock: 0x88f91d0
2007/06/04 12:10:52| comm_add_close_handler: FD 83, handler=0x806fee0,
data=0x88fa168
2007/06/04 12:10:52| cbdataLock: 0x88fa168
2007/06/04 12:10:52| ipcache_nbgethostbyname: Name
'cpacampaigns.directtrack.com'.
2007/06/04 12:10:52| ipcache_nbgethostbyname: MISS for
'cpacampaigns.directtrack.com'
2007/06/04 12:10:52| cbdataLock: 0x88fa168
2007/06/04 12:10:52| idnsALookup: buf is 46 bytes for
cpacampaigns.directtrack.com, id = 0x6543
2007/06/04 12:10:52| cbdataLock: 0x8695540
2007/06/04 12:10:52| commSetSelect: FD 6 type 1
2007/06/04 12:10:52| commSetEvents(fd=6)
2007/06/04 12:10:52| cbdataUnlock: 0x88f91d0
2007/06/04 12:10:52| storeUnlockObject: key
'02C887D62B71CA3E5B3AFAC3EE24F1CD' count=3
2007/06/04 12:10:52| cbdataFree: 0x836d5a0
2007/06/04 12:10:52| cbdataFree: Freeing 0x836d5a0
2007/06/04 12:10:52| cbdataUnlock: 0x86734d0
2007/06/04 12:10:52| cbdataUnlock: 0x8580d18
2007/06/04 12:10:52| cbdataFree: 0x836d270
2007/06/04 12:10:52| cbdataFree: Freeing 0x836d270
2007/06/04 12:10:52| cbdataUnlock: 0x86734d0
2007/06/04 12:10:52| cbdataUnlock: 0x8580d18
2007/06/04 12:10:52| cbdataFree: 0x836d0d0
2007/06/04 12:10:52| cbdataFree: Freeing 0x836d0d0
2007/06/04 12:10:52| cbdataValid: 0x8580d18
2007/06/04 12:10:52| cbdataValid: 0x8580d18
2007/06/04 12:10:52| cbdataUnlock: 0x8580d18
2007/06/04 12:10:52| commSetSelect: FD 76 type 1
2007/06/04 12:10:52| commSetEvents(fd=76)
2007/06/04 12:10:52| comm_select: timeout 735
2007/06/04 12:10:52| comm_call_handlers(): got fd=6 read_event=1
write_event=0 F->read_handler=0x8075710 F->write_handler=(nil)
2007/06/04 12:10:52| comm_call_handlers(): Calling read handler on fd=6
2007/06/04 12:10:52| idnsRead: FD 6: received 329 bytes from 127.0.0.1.
2007/06/04 12:10:52| idnsGrokReply: ID 0x6543, 1 answers
2007/06/04 12:10:52| cbdataValid: 0x8695540
2007/06/04 12:10:52| cbdataUnlock: 0x8695540
2007/06/04 12:10:52| cbdataFree: 0x8695540
2007/06/04 12:10:52| cbdataFree: Freeing 0x8695540
2007/06/04 12:10:52| ipcacheParse: #0 255.255.255.255
2007/06/04 12:10:52| cbdataValid: 0x88fa168
2007/06/04 12:10:52| ipcacheCycleAddr: cpacampaigns.directtrack.com now
at 255.255.255.255
And this is where it hangs.
It's clear that squid does not like that 255.255.255.255 IP Address, and
not surprising really.
The problem is that squid is completely wedged:
proxy 10678 0.2 0.0 0 0 ? D Jun03 2:38 [squid]
firewall:~# cat /proc/10678/status
Name: squid
State: D (disk sleep)
SleepAVG: 97%
Tgid: 10678
Pid: 10678
PPid: 10676
TracerPid: 0
Uid: 13 13 0 13
Gid: 13 13 13 13
FDSize: 0
Groups: 13
Threads: 1
SigQ: 1/3136
SigPnd: 0000000000000000
ShdPnd: 0000000000010000
SigBlk: 0000000000000000
SigIgn: 0000000000001000
SigCgt: 0000000180014a03
CapInh: 0000000000000000
CapPrm: 00000000fffffeff
CapEff: 0000000000000000
Cpus_allowed: ffffffff
Mems_allowed: 1
I have tried to remove the /var/run/squid.pid file, and restart squid,
but it fails, because this dead process still has my port (3128) bound.
The only recovery is a full machine reboot, which is not good. Luckily,
I run this in a Xen VM, otherwise I would have some really bad problems.
Thanks
Christian
-- System Information:
Debian Release: lenny/sid
APT prefers unstable
APT policy: (900, 'unstable'), (800, 'testing'), (600, 'experimental')
Architecture: amd64 (x86_64)
Kernel: Linux 2.6.21-1-amd64 (SMP w/1 CPU core)
Locale: LANG=en_US.UTF-8, LC_CTYPE=en_US.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/bash
--- End Message ---
--- Begin Message ---
I'm closing this bug since it is kernel related and not squid fault,
as pointed out by Luca and upstream developers.
Regards,
L
--
Luigi Gangitano -- <[EMAIL PROTECTED]> -- <[EMAIL PROTECTED]>
GPG: 1024D/924C0C26: 12F8 9C03 89D3 DB4A 9972 C24A F19B A618 924C 0C26
--- End Message ---
