Slippery Squid

From: Stan Dermanis <sdsquid@dont-contact.us>
Date: Wed, 9 Oct 1996 01:55:35 +1000

Hi all

BACKGROUND

I have a "slippery" question for anyone caring enough to help.I am a
teacher who helps provide Internet access and support for over 60 rural
schools in Victoria Australia.We have a Sun netra i5 which has been "rock
solid" for nearly a year now. Thankfully I have had to do very little
techically on the server other than create accounts etc which is the way it
has to be since I knowledge of Unix is very limited although its improved
markedly over the last week.

THE PROBLEM

About a month ago our technical advisor (who is situated about 400Km away)
suggested that we upgrade our proxy server so we purchased a new
machine(Intel 166/128Ram 4GB) and it was configured with Solaris 2.5 and
Squid 1.0.12 installed.Since it's introduction the cache serving has slowed
down considerably....like 50% of what it use to be.

WHAT I KNOW

I know after a number of sleepless nights that:

        *performance increases intermittantly.
        *files are being cached and served from the proxy but at much
slower rates
        *pointing my http proxy to our neighbours(both using Squid) greatly
increases performance
        *http port set to 8080 which is also the port the the Netra had the
proxy on.
                *initally the config file was set up incorrectly and Squid
would not fire-up resulting in the following errors

[02/Oct/1996:12:06:14 +1000] main.c:412: Starting Squid Cache
version 1.0.12 for i386-unknown-solaris2.5...
[02/Oct/1996:12:06:14 +1000] main.c:415: With 1024 file descriptors
available
[02/Oct/1996:12:06:14 +1000] ipcache.c:214: Performing DNS Tests...
[02/Oct/1996:12:06:14 +1000] ipcache.c:1112: Successful DNS name lookup
tests...
[02/Oct/1996:12:06:14 +1000] ipcache.c:1053: ipcacheOpenServers:
Starting 5 'dns_server' processes
[02/Oct/1996:12:06:14 +1000] neighbors.c:874: neighbors_init:
Initializing Neighbors...
[02/Oct/1996:12:06:14 +1000] neighbors.c:377: Hierachical logging is
disabled.
[02/Oct/1996:12:06:14 +1000] neighbors.c:889: Adding a neighbor:
proxy.netspace.net.au/80/3130
[02/Oct/1996:12:06:14 +1000] disk.c:203: file_open: error opening
file none: (13) Permission denied
[02/Oct/1996:12:06:14 +1000] stat.c:1054: none: (11) Resource
temporarily unavailable
FATAL: Cannot open logfile.

Squid Cache (Version 1.0.12): Terminated abnormally.
CPU Usage: user 0 sys 0
Memory Usage: rss 0 KB
Page faults with physical i/o: 0
Memory usage for squid via mallinfo():
        total space in arena: 929 KB
        Ordinary blocks: 852 KB 30 blks
        Small blocks: 5 KB 800 blks
        Holding blocks: 0 KB 8 blks
        Free Small blocks: 68 KB
        Free Ordinary blocks: 3 KB
        Total in use: 858 KB 92%
        Total free: 71 KB 8%
[28/Sep/1996:11:51:47 +1000] main.c:250: reconfigure: SIGHUP received
[28/Sep/1996:11:51:47 +1000] main.c:251: Waiting 30 seconds for
active connections to finish
[28/Sep/1996:11:51:48 +1000] main.c:341: FD 17 Closing HTTP connection
[28/Sep/1996:11:51:48 +1000] main.c:353: FD 18 Closing ICP connection
[28/Sep/1996:11:51:48 +1000] main.c:372: Restarting Squid Cache
(version 1.0.12)...
[28/Sep/1996:11:51:48 +1000] neighbors.c:874: neighbors_init:
Initializing Neighbors...
[28/Sep/1996:11:51:48 +1000] neighbors.c:377: Hierachical logging is
disabled.
[28/Sep/1996:11:51:48 +1000] neighbors.c:889: Adding a neighbor:
proxy.netspace.net.au/80/3130
[28/Sep/1996:11:51:48 +1000] ipcache.c:1053: ipcacheOpenServers:
Starting 5 'dns_server' processes
[28/Sep/1996:11:51:48 +1000] main.c:295: Accepting HTTP connections
on FD 13.
[28/Sep/1996:11:51:48 +1000] main.c:311: Accepting ICP connections
on FD 14.
[28/Sep/1996:11:51:48 +1000] main.c:384: Ready to serve requests.
[28/Sep/1996:11:53:38 +1000] store_clean.c:98: Cleaned 2 unused
.
etc
.
.
.files from /export/home/cache/92
[28/Sep/1996:13:34:57 +1000] store_clean.c:98: Cleaned 1 unused files
from /export/home/cache/97
[28/Sep/1996:13:35:58 +1000] store_clean.c:98: Cleaned 1 unused files
from /export/home/cache/98
[28/Sep/1996:13:37:00 +1000] store_clean.c:98: Cleaned 1 unused files
from /export/home/cache/99
[28/Sep/1996:13:41:12 +1000] comm.c:372: connect: 132.234.5.1:80:
(32) Broken pipe.
[28/Sep/1996:16:52:19 +1000] comm.c:1201: commHandleRead: FD 24:
read failure: (131) Connection reset by peer
[28/Sep/1996:18:11:03 +1000] comm.c:372: connect: 206.28.204.3:80::
(32) Broken pipe.
[28/Sep/1996:18:58:18 +1000] comm.c:1201: commHandleRead: FD 21:
read failure: (131) Connection reset by peer
[28/Sep/1996:19:11:53 +1000] comm.c:372: connect:
192.216.191.92:80: (32) Broken pipe.
[28/Sep/1996:19:25:26 +1000] comm.c:1201: commHandleRead: FD 20:
read failure: (131) Connection reset by peer
[28/Sep/1996:20:27:21 +1000] ftpget: ERROR: ftpget.c [657]: write: (32)
Broken pipe
[28/Sep/1996:20:27:21 +1000] ftpget: ERROR: ftpget.c [657]: write: (32)
Broken pipe
[28/Sep/1996:21:27:56 +1000] icp.c:1894: icpDetectClientClose: FD
19, 2 unexpected bytes
[28/Sep/1996:22:27:53 +1000] comm.c:372: connect:
129.94.238.14:3880: (32) Broken pipe.
[28/Sep/1996:22:28:08 +1000] comm.c:372: connect:
129.94.238.14:3880: (32) Broken pipe.
[28/Sep/1996:22:32:06 +1000] comm.c:1201: commHandleRead: FD 15:
read failure: (131) Connection reset by peer
[29/Sep/1996:01:13:40 +1000] icp.c:1894: icpDetectClientClose: FD
15, 1 unexpected bytes
[29/Sep/1996:01:14:52 +1000] ftpget: ERROR: ftpget.c [657]: write: (32)
Broken pipe
[29/Sep/1996:01:14:52 +1000] ftpget: ERROR: ftpget.c [657]: write: (32)
Broken pipe
[29/Sep/1996:01:28:04 +1000] comm.c:1201: commHandleRead: FD 15:
read failure: (131) Connection reset by peer
[29/Sep/1996:09:28:05 +1000] comm.c:372: connect: 199.86.48.200:80:
(32) Broken pipe.
.
etc
.
.
.207.77.204.10:80: (32) Broken pipe.
[29/Sep/1996:11:05:37 +1000] comm.c:372: connect: 207.77.204.10:80:
(32) Broken pipe.
[29/Sep/1996:12:17:25 +1000] comm.c:1201: commHandleRead: FD 20:
read failure: (131) Connection reset by peer
[29/Sep/1996:12:17:26 +1000] comm.c:1201: commHandleRead: FD 19:
read failure: (131) Connection reset by peer
[29/Sep/1996:12:39:45 +1000] neighbors.c:570: neighborsUdpPing: Detected
DEAD SIBLING: proxy.netspace.net.au
[29/Sep/1996:12:39:46 +1000] neighbors.c:638: neighborsUdpAck: Detected
REVIVED SIBLING: proxy.netspace.net.au
[29/Sep/1996:12:58:23 +1000] icp.c:1491: parseHttpRequest:
Unsupported method '?

Is this cleaning process normal,the hard disk should have plenty of space???

I've also noted that it "runs" on even after I've terminated a request even
though quick abort in the config file is "on"

The decrease in performance is especially evident for dial-up modem access.

Can anybody help or suggest somewhere or something I could try.The guys who
set it up have not made it a priority to fix the problem and our schools
come back from their break this Monday after a break.

In complete and utter desperation

Stan
----------------------------------
WimmeraNet
Internet Access and Support
for Wimmera Schools
by Wimmera Schools

http://www.wimmera.net.au/
admin@wimmera.net.au
----------------------------------
Received on Tue Oct 08 1996 - 08:56:14 MDT

This archive was generated by hypermail pre-2.1.9 : Tue Dec 09 2003 - 16:33:15 MST