Re: [squid-users] Squid shuts down often

From: Amos Jeffries <squid3_at_treenet.co.nz>
Date: Sat, 01 Aug 2009 23:32:30 +1200

Dylan Palmboom wrote:
> Hi
>
> We have squid running fine, but every now and then the network connection to
> squid goes down.
> Then if you try ping the host, it fails.
> After the server is restarted, it works again until next time.
>
> I have included a section from cache.log which is when squid stopped
> working.
> I see near the bottom of the log it says it's shutting down...
>
> ****************************************************************************
> ****
> CPU Usage: 11.009 seconds = 5.812 user + 5.196 sys
> Maximum Resident Size: 0 KB
> Page faults with physical i/o: 3
> Memory usage for squid via mallinfo():
> total space in arena: 14872 KB
> Ordinary blocks: 14684 KB 285 blks
> Small blocks: 0 KB 0 blks
> Holding blocks: 1108 KB 1 blks
> Free Small blocks: 0 KB
> Free Ordinary blocks: 187 KB
> Total in use: 15792 KB 99%
> Total free: 187 KB 1%
> 2009/07/31 10:20:18| logfileClose: closing log /var/log/squid/store.log
> 2009/07/31 10:20:18| logfileClose: closing log /var/log/squid/access.log
> 2009/07/31 10:20:18| Squid Cache (Version 2.7.STABLE5): Exiting normally.
> 2009/07/31 10:20:21| Starting Squid Cache version 2.7.STABLE5 for
> i686-pc-linux-gnu...
> 2009/07/31 10:20:21| Process ID 14362
> 2009/07/31 10:20:21| With 4096 file descriptors available
> 2009/07/31 10:20:21| Using epoll for the IO loop
> 2009/07/31 10:20:21| DNS Socket created at 0.0.0.0, port 44027, FD 6
> 2009/07/31 10:20:21| Adding domain eva.dbn from /etc/resolv.conf
> 2009/07/31 10:20:21| Adding nameserver 192.168.1.10 from /etc/resolv.conf
> 2009/07/31 10:20:21| User-Agent logging is disabled.
> 2009/07/31 10:20:21| Referer logging is disabled.
> 2009/07/31 10:20:21| logfileOpen: opening log /var/log/squid/access.log
> 2009/07/31 10:20:21| Unlinkd pipe opened on FD 11
> 2009/07/31 10:20:21| Swap maxSize 102400 + 8192 KB, estimated 0 objects
> 2009/07/31 10:20:21| Target number of buckets: 425
> 2009/07/31 10:20:21| Using 8192 Store buckets
> 2009/07/31 10:20:21| Max Mem size: 8192 KB
> 2009/07/31 10:20:21| Max Swap size: 102400 KB
> 2009/07/31 10:20:21| Local cache digest enabled; rebuild/rewrite every
> 3600/3600 sec
> 2009/07/31 10:20:21| logfileOpen: opening log /var/log/squid/store.log
> 2009/07/31 10:20:21| Rebuilding storage in /var/cache/squid (CLEAN)
> 2009/07/31 10:20:21| Using Least Load store dir selection
> 2009/07/31 10:20:21| Set Current Directory to /var/cache/squid
> 2009/07/31 10:20:21| Loaded Icons.
> 2009/07/31 10:20:22| Accepting transparently proxied HTTP connections at
> 192.168.1.11, port 3128, FD 13.
> 2009/07/31 10:20:22| Accepting ICP messages at 0.0.0.0, port 3130, FD 14.
> 2009/07/31 10:20:22| HTCP Disabled.
> 2009/07/31 10:20:22| Accepting SNMP messages on port 3401, FD 15.
> 2009/07/31 10:20:22| WCCP Disabled.
> 2009/07/31 10:20:22| Pinger socket opened on FD 16
> 2009/07/31 10:20:22| Ready to serve requests.
> 2009/07/31 10:20:22| Store rebuilding is 57.4% complete
> 2009/07/31 10:20:22| Done reading /var/cache/squid swaplog (7138 entries)
> 2009/07/31 10:20:22| Finished rebuilding storage from disk.
> 2009/07/31 10:20:22| 7138 Entries scanned
> 2009/07/31 10:20:22| 0 Invalid entries.
> 2009/07/31 10:20:22| 0 With invalid flags.
> 2009/07/31 10:20:22| 7138 Objects loaded.
> 2009/07/31 10:20:22| 0 Objects expired.
> 2009/07/31 10:20:22| 0 Objects cancelled.
> 2009/07/31 10:20:22| 0 Duplicate URLs purged.
> 2009/07/31 10:20:22| 0 Swapfile clashes avoided.
> 2009/07/31 10:20:22| Took 0.3 seconds (22618.5 objects/sec).
> 2009/07/31 10:20:22| Beginning Validation Procedure
> 2009/07/31 10:20:22| Completed Validation Procedure
> 2009/07/31 10:20:22| Validated 7138 Entries
> 2009/07/31 10:20:22| store_swap_size = 92156k
> 2009/07/31 10:20:22| storeLateRelease: released 0 objects
> 2009/07/31 10:21:33| Preparing for shutdown after 0 requests
> 2009/07/31 10:21:33| Waiting 30 seconds for active connections to finish
> 2009/07/31 10:21:33| FD 13 Closing HTTP connection
> 2009/07/31 10:21:33| Closing Pinger socket on FD 16
> 2009/07/31 10:21:33| Shutting down...
> 2009/07/31 10:21:33| FD 14 Closing ICP connection
> 2009/07/31 10:21:33| FD 15 Closing SNMP socket
> 2009/07/31 10:21:33| Closing unlinkd pipe on FD 11
> 2009/07/31 10:21:33| storeDirWriteCleanLogs: Starting...
> 2009/07/31 10:21:33| Finished. Wrote 7138 entries.
> 2009/07/31 10:21:33| Took 0.0 seconds (4790604.0 entries/sec).
>
>
> Please could someone tell me if they know what is causing this.
>

Someone has told Squid to restart.

Running "squid -k restart" will do that.
So will sending the process ID the restart signal.
So will passing the CacheMgr control system a requests for the "restart"
object.

A manual restart is the only way I know of that will cause that "Exiting
normally." message.

Amos

-- 
Please be using
   Current Stable Squid 2.7.STABLE6 or 3.0.STABLE17
   Current Beta Squid 3.1.0.12
Received on Sat Aug 01 2009 - 11:32:41 MDT

This archive was generated by hypermail 2.2.0 : Sat Aug 01 2009 - 12:00:06 MDT