[squid-users] Squid 3.2.7 dies: icap_retry deny all

From: Sandrini Christian \(xsnd\) <xsnd_at_zhaw.ch>
Date: Fri, 1 Mar 2013 07:48:49 +0000

Hi

My squid dies almost every day with the following entries in the cache.log

I am using Centos 6.3 & squid-3.2.7-1.el6.x86_64

2013/03/01 01:55:36 kid1| Starting Squid Cache version 3.2.7 for x86_64-unknown-linux-gnu...
2013/03/01 01:55:36 kid1| Process ID 2937
2013/03/01 01:55:36 kid1| Process Roles: worker
2013/03/01 01:55:36 kid1| With 65535 file descriptors available
2013/03/01 01:55:36 kid1| Initializing IP Cache...
2013/03/01 01:55:36 kid1| DNS Socket created at 0.0.0.0, FD 7
2013/03/01 01:55:36 kid1| Adding nameserver 160.85.192.100 from squid.conf
2013/03/01 01:55:36 kid1| Logfile: opening log daemon:/var/log/squid/access.log
2013/03/01 01:55:36 kid1| Logfile Daemon: opening log /var/log/squid/access.log
2013/03/01 01:55:36 kid1| Local cache digest enabled; rebuild/rewrite every 3600/3600 sec
2013/03/01 01:55:36 kid1| Store logging disabled
2013/03/01 01:55:36 kid1| Swap maxSize 25600000 + 3145728 KB, estimated 2211209 objects
2013/03/01 01:55:36 kid1| Target number of buckets: 110560
2013/03/01 01:55:36 kid1| Using 131072 Store buckets
2013/03/01 01:55:36 kid1| Max Mem size: 3145728 KB
2013/03/01 01:55:36 kid1| Max Swap size: 25600000 KB
2013/03/01 01:55:36 kid1| Rebuilding storage in /var/cache/squid (clean log)
2013/03/01 01:55:36 kid1| Using Least Load store dir selection
2013/03/01 01:55:36 kid1| Set Current Directory to /var/spool/squid
2013/03/01 01:55:36 kid1| Loaded Icons.
2013/03/01 01:55:36 kid1| HTCP Disabled.
2013/03/01 01:55:36 kid1| Squid plugin modules loaded: 0
2013/03/01 01:55:36 kid1| Adaptation support is off.
2013/03/01 01:55:36 kid1| Accepting HTTP Socket connections at local=160.85.104.14:8080 remote=[::] FD 12 flags=9
2013/03/01 01:55:36 kid1| Store rebuilding is 0.90% complete
2013/03/01 01:55:38 kid1| Done reading /var/cache/squid swaplog (446056 entries)
2013/03/01 01:55:38 kid1| Finished rebuilding storage from disk.
2013/03/01 01:55:38 kid1| 446054 Entries scanned
2013/03/01 01:55:38 kid1| 2 Invalid entries.
2013/03/01 01:55:38 kid1| 0 With invalid flags.
2013/03/01 01:55:38 kid1| 446037 Objects loaded.
2013/03/01 01:55:38 kid1| 0 Objects expired.
2013/03/01 01:55:38 kid1| 0 Objects cancelled.
2013/03/01 01:55:38 kid1| 6 Duplicate URLs purged.
2013/03/01 01:55:38 kid1| 11 Swapfile clashes avoided.
2013/03/01 01:55:38 kid1| Took 1.76 seconds (253274.55 objects/sec).
2013/03/01 01:55:38 kid1| Beginning Validation Procedure
2013/03/01 01:55:38 kid1| 262144 Entries Validated so far.
2013/03/01 01:55:38 kid1| Completed Validation Procedure
2013/03/01 01:55:38 kid1| Validated 446034 Entries
2013/03/01 01:55:38 kid1| store_swap_size = 10760564.00 KB
2013/03/01 01:55:38 kid1| storeLateRelease: released 0 objects
2013/03/01 01:56:20 kid1| Closing HTTP port 160.85.104.14:8080
2013/03/01 01:56:20 kid1| storeDirWriteCleanLogs: Starting...
2013/03/01 01:56:20 kid1| 65536 entries written so far.
2013/03/01 01:56:20 kid1| 131072 entries written so far.
2013/03/01 01:56:20 kid1| 196608 entries written so far.
2013/03/01 01:56:20 kid1| 262144 entries written so far.
2013/03/01 01:56:20 kid1| 327680 entries written so far.
2013/03/01 01:56:20 kid1| 393216 entries written so far.
2013/03/01 01:56:20 kid1| Finished. Wrote 446088 entries.
2013/03/01 01:56:20 kid1| Took 0.06 seconds (7136608.70 entries/sec).
FATAL: Bungled (null) line 8: icap_retry deny all
Squid Cache (Version 3.2.7): Terminated abnormally.
CPU Usage: 1.930 seconds = 1.050 user + 0.880 sys
Maximum Resident Size: 449232 KB
Page faults with physical i/o: 22
Memory usage for squid via mallinfo():
        total space in arena: 95588 KB
        Ordinary blocks: 95304 KB 37 blks
        Small blocks: 0 KB 1 blks
        Holding blocks: 38936 KB 9 blks
        Free Small blocks: 0 KB
        Free Ordinary blocks: 283 KB
        Total in use: 134240 KB 140%
        Total free: 283 KB 0%
2013/03/01 01:56:23 kid1| Starting Squid Cache version 3.2.7 for x86_64-unknown-linux-gnu...
2013/03/01 01:56:23 kid1| Process ID 2957
2013/03/01 01:56:23 kid1| Process Roles: worker
2013/03/01 01:56:23 kid1| With 65535 file descriptors available
2013/03/01 01:56:23 kid1| Initializing IP Cache...
2013/03/01 01:56:23 kid1| DNS Socket created at 0.0.0.0, FD 7
2013/03/01 01:56:23 kid1| Adding nameserver 160.85.192.100 from squid.conf
2013/03/01 01:56:23 kid1| Logfile: opening log daemon:/var/log/squid/access.log
2013/03/01 01:56:23 kid1| Logfile Daemon: opening log /var/log/squid/access.log
2013/03/01 01:56:23 kid1| Local cache digest enabled; rebuild/rewrite every 3600/3600 sec
2013/03/01 01:56:23 kid1| Store logging disabled
2013/03/01 01:56:23 kid1| Swap maxSize 25600000 + 3145728 KB, estimated 2211209 objects
2013/03/01 01:56:23 kid1| Target number of buckets: 110560
2013/03/01 01:56:23 kid1| Using 131072 Store buckets
2013/03/01 01:56:23 kid1| Max Mem size: 3145728 KB
2013/03/01 01:56:23 kid1| Max Swap size: 25600000 KB
2013/03/01 01:56:23 kid1| Rebuilding storage in /var/cache/squid (clean log)
2013/03/01 01:56:23 kid1| Using Least Load store dir selection
2013/03/01 01:56:23 kid1| Set Current Directory to /var/spool/squid
2013/03/01 01:56:23 kid1| Loaded Icons.
2013/03/01 01:56:23 kid1| HTCP Disabled.
2013/03/01 01:56:23 kid1| Squid plugin modules loaded: 0
2013/03/01 01:56:23 kid1| Adaptation support is off.
2013/03/01 01:56:23 kid1| Accepting HTTP Socket connections at local=160.85.104.14:8080 remote=[::] FD 12 flags=9
2013/03/01 01:56:23 kid1| Store rebuilding is 0.90% complete
2013/03/01 01:56:25 kid1| Done reading /var/cache/squid swaplog (446088 entries)
2013/03/01 01:56:25 kid1| Finished rebuilding storage from disk.
2013/03/01 01:56:25 kid1| 446088 Entries scanned
2013/03/01 01:56:25 kid1| 0 Invalid entries.
2013/03/01 01:56:25 kid1| 0 With invalid flags.
2013/03/01 01:56:25 kid1| 446071 Objects loaded.
2013/03/01 01:56:25 kid1| 0 Objects expired.
2013/03/01 01:56:25 kid1| 0 Objects cancelled.
2013/03/01 01:56:25 kid1| 8 Duplicate URLs purged.
2013/03/01 01:56:25 kid1| 9 Swapfile clashes avoided.
2013/03/01 01:56:25 kid1| Took 1.63 seconds (274269.27 objects/sec).
2013/03/01 01:56:25 kid1| Beginning Validation Procedure
2013/03/01 01:56:25 kid1| 262144 Entries Validated so far.
2013/03/01 01:56:25 kid1| Completed Validation Procedure
2013/03/01 01:56:25 kid1| Validated 446068 Entries
2013/03/01 01:56:25 kid1| store_swap_size = 10761108.00 KB
2013/03/01 01:56:25 kid1| storeLateRelease: released 1 objects
2013/03/01 02:06:58 kid1| Failed to select source for 'http://gzbhwv.ch/index.php?option=com_content&task=view&id=14&Itemid=35'
2013/03/01 02:06:58 kid1| always_direct = 0
2013/03/01 02:06:58 kid1| never_direct = 0
2013/03/01 02:06:58 kid1| timedout = 0
2013/03/01 02:07:01 kid1| Failed to select source for 'http://gzbhwv.ch/index.php?option=com_content&task=view&id=14&Itemid=35'
2013/03/01 02:07:01 kid1| always_direct = 0
2013/03/01 02:07:01 kid1| never_direct = 0
2013/03/01 02:07:01 kid1| timedout = 0
2013/03/01 02:18:02 kid1| Closing HTTP port 160.85.104.14:8080
2013/03/01 02:18:02 kid1| storeDirWriteCleanLogs: Starting...
2013/03/01 02:18:02 kid1| 65536 entries written so far.
2013/03/01 02:18:02 kid1| 131072 entries written so far.
2013/03/01 02:18:02 kid1| 196608 entries written so far.
2013/03/01 02:18:02 kid1| 262144 entries written so far.
2013/03/01 02:18:02 kid1| 327680 entries written so far.
2013/03/01 02:18:02 kid1| 393216 entries written so far.
2013/03/01 02:18:02 kid1| Finished. Wrote 446450 entries.
2013/03/01 02:18:02 kid1| Took 0.07 seconds (6463638.86 entries/sec).

This is in the messages :

Mar 1 01:55:30 srv-app-904 (squid-1): Bungled (null) line 8: icap_retry deny all
Mar 1 01:55:32 srv-app-904 squid[2153]: Squid Parent: (squid-1) process 2156 exited with status 1
Mar 1 01:55:35 srv-app-904 squid[2153]: Squid Parent: (squid-1) process 2937 started
Mar 1 01:56:20 srv-app-904 (squid-1): Bungled (null) line 8: icap_retry deny all
Mar 1 01:56:20 srv-app-904 squid[2153]: Squid Parent: (squid-1) process 2937 exited with status 1
Mar 1 01:56:23 srv-app-904 squid[2153]: Squid Parent: (squid-1) process 2957 started
Mar 1 02:18:02 srv-app-904 (squid-1): Bungled (null) line 8: icap_retry deny all
Mar 1 02:18:02 srv-app-904 squid[2153]: Squid Parent: (squid-1) process 2957 exited with status 1
Mar 1 02:18:05 srv-app-904 squid[2153]: Squid Parent: (squid-1) process 2998 started
Mar 1 02:18:18 srv-app-904 (squid-1): Bungled (null) line 8: icap_retry deny all
Mar 1 02:18:18 srv-app-904 squid[2153]: Squid Parent: (squid-1) process 2998 exited with status 1
Mar 1 02:18:21 srv-app-904 squid[2153]: Squid Parent: (squid-1) process 3017 started
Mar 1 03:18:02 srv-app-904 logrotate: ALERT exited abnormally with [1]

Any idea what the reason could be? I had the same with 3.2.6
Received on Fri Mar 01 2013 - 08:57:02 MST

This archive was generated by hypermail 2.2.0 : Fri Mar 01 2013 - 12:00:04 MST