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 -- To UNSUBSCRIBE, email to [EMAIL PROTECTED] with a subject of "unsubscribe". Trouble? Contact [EMAIL PROTECTED]
