Re: [SQU] Squid takes an hour to restart.

From your logs the problem looks to be the dnsserver processes
starting. Maybe a debug 0,9 might shed some light.

Jai Lamerton

On Mon, 13 Nov 2000, Mark Pleasance wrote:

> Hello all,
>
> I'm running Squid 2.2STABLE5 on RH 6.2 and each time I restart either the
> computer or squid (squid -k shutdown then ./squid) it takes an hour to start
> up. Here's the cache.log entries;
>
> Our DNS server wasn't responding so Squid exited. The DNS server was fixed
> at 11:42.
>
> 2000/11/07 11:41:01| sslReadClient: FD 38: read failure: (104) Connection
> reset by peer
> 2000/11/07 11:41:12| WARNING: All dnsserver processes are busy.
> 2000/11/07 11:41:12| WARNING: 57 pending requests queued
> 2000/11/07 11:41:12| storeDirWriteCleanLogs: Starting...
> 2000/11/07 11:41:12| WARNING: Closing open FD 62
> 2000/11/07 11:41:12| 65536 entries written so far.
> 2000/11/07 11:41:12| 131072 entries written so far.
> 2000/11/07 11:41:12| 196608 entries written so far.
> 2000/11/07 11:41:12| 262144 entries written so far.
> 2000/11/07 11:41:12| 327680 entries written so far.
> 2000/11/07 11:41:13| 393216 entries written so far.
> 2000/11/07 11:41:13| Finished. Wrote 414710 entries.
> 2000/11/07 11:41:13| Took 1 seconds (414710.0 entries/sec).
> FATAL: Too many queued dnsserver requests
> Squid Cache (Version 2.2.STABLE5): Terminated abnormally.
> CPU Usage: 4305.220 seconds
> Maximum Resident Size: 0 KB
> Page faults with physical i/o: 399995
> Memory usage for squid via mallinfo():
> total space in arena: 59891 KB
> Ordinary blocks: 59063 KB 8203 blks
> Small blocks: 0 KB 0 blks
> Holding blocks: 308 KB 2 blks
> Free Small blocks: 0 KB
> Free Ordinary blocks: 827 KB
> Total in use: 59371 KB 99%
> Total free: 827 KB 1%
> 2000/11/07 11:41:18| Starting Squid Cache version 2.2.STABLE5 for
> i686-pc-linux-gnu...
> 2000/11/07 11:41:18| Process ID 24158
> 2000/11/07 11:41:18| With 1024 file descriptors available
> 2000/11/07 11:41:18| Performing DNS Tests...
> 2000/11/07 11:41:18| Successful DNS name lookup tests...
> 2000/11/07 11:41:18| helperOpenServers: Starting 15 'dnsserver' processes
> 2000/11/07 13:02:26| helperOpenServers: Starting 10 'squidGuard' processes
> 2000/11/07 13:02:26| helperOpenServers: Starting 5 'ncsa_auth' processes
> 2000/11/07 13:02:26| Unlinkd pipe opened on FD 35
> 2000/11/07 13:02:26| Swap maxSize 12226560 KB, estimated 940504 objects
> 2000/11/07 13:02:26| Target number of buckets: 18810
> 2000/11/07 13:02:26| Using 32768 Store buckets, replacement runs every 2
> seconds
> 2000/11/07 13:02:26| Max Mem size: 10240 KB
> 2000/11/07 13:02:26| Max Swap size: 12226560 KB
> 2000/11/07 13:02:26| Rebuilding storage in Cache Dir #0 (CLEAN)
> 2000/11/07 13:02:26| Rebuilding storage in Cache Dir #1 (CLEAN)
> 2000/11/07 13:02:26| Rebuilding storage in Cache Dir #2 (CLEAN)
> 2000/11/07 13:02:26| Set Current Directory to /cache01
> 2000/11/07 13:02:26| Loaded Icons.
> 2000/11/07 13:02:27| Accepting HTTP connections on port 3128, FD 62.
> 2000/11/07 13:02:27| Accepting HTTP connections on port 8080, FD 63.
> 2000/11/07 13:02:27| Accepting ICP messages on port 3130, FD 64.
> 2000/11/07 13:02:27| Ready to serve requests.
> 2000/11/07 13:02:28| 65536 Entries read so far.
> 2000/11/07 13:02:29| 131072 Entries read so far.
> 2000/11/07 13:02:30| 196608 Entries read so far.
> 2000/11/07 13:02:31| 262144 Entries read so far.
> 2000/11/07 13:02:32| 327680 Entries read so far.
> 2000/11/07 13:02:33| 393216 Entries read so far.
> 2000/11/07 13:02:34| Done reading Cache Dir #2 swaplog (136401 entries)
> 2000/11/07 13:02:34| Done reading Cache Dir #0 swaplog (136595 entries)
> 2000/11/07 13:02:34| Done reading Cache Dir #1 swaplog (141714 entries)
> 2000/11/07 13:02:34| Finished rebuilding storage disk.
> 2000/11/07 13:02:34| 414710 Entries read from previous logfile.
> 2000/11/07 13:02:34| 0 Entries scanned from swap files.
> 2000/11/07 13:02:34| 0 Invalid entries.
> 2000/11/07 13:02:34| 0 With invalid flags.
> 2000/11/07 13:02:34| 414710 Objects loaded.
> 2000/11/07 13:02:34| 0 Objects expired.
> 2000/11/07 13:02:34| 0 Objects cancelled.
> 2000/11/07 13:02:34| 0 Duplicate URLs purged.
> 2000/11/07 13:02:34| 0 Swapfile clashes avoided.
> 2000/11/07 13:02:34| Took 8 seconds (51838.8 objects/sec).
> 2000/11/07 13:02:34| Beginning Validation Procedure
> 2000/11/07 13:02:34| 65536 Entries Validated so far.
> 2000/11/07 13:02:34| 131072 Entries Validated so far.
> 2000/11/07 13:02:34| 196608 Entries Validated so far.
> 2000/11/07 13:02:34| 262144 Entries Validated so far.
> 2000/11/07 13:02:34| 327680 Entries Validated so far.
> 2000/11/07 13:02:34| 393216 Entries Validated so far.
> 2000/11/07 13:02:34| Completed Validation Procedure
> 2000/11/07 13:02:34| Validated 414710 Entries
> 2000/11/07 13:02:34| store_swap_size = 4763081k
> 2000/11/07 13:02:35| storeLateRelease: released 0 objects
>
>
> Anybody have any ideas why this takes so long??
>
> Thanks
>
> Mark
>
> ---------------------------------------------------------------
> Mark Pleasance mark@crc.vic.edu.au
> Computer Tech/Network Administrator
> Catholic Regional College
> Geelong, Victoria, Australia
> ---------------------------------------------------------------
>
>
>
> --
> To unsubscribe, see http://www.squid-cache.org/mailing-lists.html
>

--
To unsubscribe, see http://www.squid-cache.org/mailing-lists.html