Still a very slow response... Just upgraded to beta28, more instable... HELP! I'm dying...

From: Walter Klomp <walter@dont-contact.us>
Date: Fri, 6 Dec 1996 22:07:17 +0800

Hi again...

| Now I am running squid 1.1beta28 on a dual pentium 133 with 192Mb RAM on SCO
Unix
| (I though should be powerful enough :-) I am connected via a 256k leased
line
| to my parent squid cache's which respond normally within 10ms .. 50ms,
| according to cachemgr. I have 12 dns server running of which 5 are not used
yet...

However if I set the cache_mem to 16Mb the squid will not run for more than
5-30 minutes. It will just restart without giving any error messages. What is
going on?

I put in the changes in the cache-parameters and now it seems to cache more, I
see the cache grow, however the internal cache is still only 8Mb, because I
cannot set it higher. I heard from another squid cache user (my parent squid
cache) that he had to tweak his unix kernel quite a bit in order to make it run
efficiently. However I was able to have a very fast proxy server in the
beginning with only a pentium 60 and 96Mb RAM on a 128k leased line, but now my
dual pentium system cannot even match that performance with a 256k leased line
:-( The operating system is the same, what can be wrong? My CPU is only used
around 30% and memory around 30% as well... disk usage 10%... I give an excerpt
from the access.log

96/12/06 21:57:31| ERR_CLIENT_ABORT:
http://altavista.digital.com/cgi-bin/query?
pg=q&stq=80&q=gay+cum
96/12/06 21:58:10| ERR_CLIENT_ABORT:
http://www.mallbymodem.com/gifimage/home.gi
f
96/12/06 21:58:15| ERR_CLIENT_ABORT:
http://seek-p.infoseek.com/Titles?qt=wong+l
i+ling&col=WW&sv=N3
96/12/06 21:58:16| ERR_CLIENT_ABORT:
http://seek-p.infoseek.com/redirect?sv=N3&a
k=BUIK-2000-1004-GEN&rd=http://www.nrsite.com/click.ng;spacedesc=GM1_Infoseek_Ba

nnerMatch_Any
96/12/06 21:58:22| WARNING: Over store_pages high-water mark (4032 > 3686)
96/12/06 21:58:22| Perhaps you should increase cache_mem?
96/12/06 21:58:22| storeGetMemSpace stats:
96/12/06 21:58:22| 12 objects locked in memory
96/12/06 21:58:22| 42 LRU candidates
96/12/06 21:58:22| 28 were purged
96/12/06 21:58:22| 14 were released
96/12/06 21:58:23| ERR_CLIENT_ABORT:
http://www.bekkoame.or.jp/~belan/pics/96100
02.jpg
96/12/06 21:58:25| ERR_READ_TIMEOUT:
http://java.sun.com/tutorial/applet/overvie
w/index.html
96/12/06 21:58:46| storeStartDeleteBehind:
'ftp://ftp.nus.sg/pub/infoserver/nets
cape/navigator/gold/3.01/windows/g32e301p.exe' at 4194554 bytes
96/12/06 21:58:59| ERR_CLIENT_ABORT:
http://www.regal.com/cgi-bin/regal_launch.p
l
96/12/06 21:59:04| ERR_READ_ERROR:
http://irc.swiftech.com.sg:8080/Theme/list.ht
m?NICK=nick&NAME=freddy
96/12/06 21:59:10| ERR_CLIENT_ABORT: http://counter.digits.com/wc/-d/4/Butts
96/12/06 21:59:18| ERR_CLIENT_ABORT:
http://dspace.dial.pipex.com/elecktra/index
.htm
96/12/06 21:59:19| ERR_CLIENT_ABORT:
http://altavista.digital.com/cgi-bin/query/
?pg=q&what=web&fmt=in+Standard+Form&q=playboy
96/12/06 21:59:29| icpDetectClientClose: ERROR 202.42.208.202: (114) Connection
timed out
96/12/06 21:59:55| ERR_CLIENT_ABORT:
http://ivory.nosc.mil/cgi-bin/counter?LIBRA
RY_c&COUNT=0&reverse=true
96/12/06 21:59:57| ERR_READ_ERROR:
http://irc.swiftech.com.sg:8080/Theme/list.ht
m?NICK=nick&NAME=freddy
96/12/06 22:00:00| ERR_DNS_FAIL: http://http.swiftech.com.sg/
96/12/06 22:00:08| ERR_READ_ERROR:
http://irc.swiftech.com.sg:8080/Theme/list.ht
m?NICK=nick&NAME=freddy&CHANNEL=%23lobby
96/12/06 22:00:09| ERR_CLIENT_ABORT:
http://altavista.digital.com/cgi-bin/query/
?pg=q&what=web&fmt=in+Standard+Form&q=playboy

I think I'll reboot the server once again and try 16Mb cache_mem...

dated Fri Dec 6 22:00:18 1996

Squid Object Cache: Version 1.1.beta28
Start Time: Fri, 06 Dec 1996 12:31:23 GMT
Current Time: Fri, 06 Dec 1996 14:02:46 GMT
Connection information for squid:
        Number of TCP connections: 21792
        Number of UDP connections: 0
        Connections per hour: 14308.1
Cache information for squid:
        Storage Swap size: 1108 MB
        Storage Mem size: 13714 KB
Memory usage for squid via mallinfo():
        Total space in arena: 31636 KB
        Ordinary blocks: 30054 KB 201686 blks
        Small blocks: 48 KB 7616 blks
        Holding blocks: 1 KB 238 blks
        Free Small blocks: 70 KB
        Free Ordinary blocks: 1581 KB
        Total in use: 30104 KB 95%
        Total free: 1651 KB 5%
File descriptor usage for squid:
        Max number of file desc available: 3000
        Largest file desc currently in use: 179
        Available number of file descriptors: 2835
        Reserved number of file descriptors: 100
Internal Data Structures:
         90673 StoreEntries
           188 StoreEntries with MemObjects
           188 StoreEntries with MemObject Data
           124 Hot Object Cache Items
Accounted Memory Usage:
        StoreEntry 90673 x 52 bytes = 4604 KB
        URL strings = 4241 KB
        IPCacheEntry 774 x 36 bytes = 27 KB
        FQDNCacheEntry 0 x 56 bytes = 0 KB
        Hash link 124 x 12 bytes = 1 KB
        Pool MemObject structures 375 x 92 bytes = 33 KB ( 16 free)
        Pool for Request structur 156 x 4520 bytes = 688 KB ( 145 free)
        Pool for in-memory object 4096 x 4096 bytes = 16384 KB ( 2252 free)
        Pool for disk I/O 62 x 8192 bytes = 496 KB ( 208 free)
        NetDB Address Entries 0 x 72 bytes = 0 KB
        NetDB Host Entries 0 x 8 bytes = 0 KB
        ClientDB Entries 129 x 160 bytes = 20 KB
        Miscellaneous = 2075 KB
        Total Accounted = 28573 KB

------------------------------------------------------------------------
Generated Friday, 06-Dec-96 14:00:18 GMT, by
cachemgr.cgi/1.1.beta28@sco.swiftech.com.sg

O.k... here's an cut out of the access.log after the reboot, however still
slow...

849881032.160 500 202.42.236.158 TCP_HIT/200 7455 GET http://www.windows95.co
m/gifs/ads/webtrend2.gif - NONE/- image/gif
849881032.200 140 202.42.208.160 TCP_HIT/200 217 GET http://www.yahoo.com/ima
ges/new2.gif - NONE/- image/gif
849881032.300 640 202.42.236.158 TCP_HIT/200 4579 GET http://www.windows95.co
m/gifs/ads/avalanad.gif - NONE/- image/gif
849881032.300 240 202.42.208.160 TCP_HIT/200 617 GET http://my.yahoo.com/imag
es/yahoo.gif - NONE/- image/gif
849881032.350 210 202.42.208.160 TCP_HIT/200 1463 GET http://my.yahoo.com/ima
ges/logout.gif - NONE/- image/gif
849881032.360 340 202.42.236.158 TCP_HIT/200 10179 GET http://www.windows95.c
om/vservers/rufftimesad.gif - NONE/- image/gif
849881034.1807280 202.42.236.224 TCP_MISS/200 1868 GET http://www.xxxgirls.co
m/mapcom/2girl.html - TIMEOUT_FIRST_PARENT_MISS/palo1.pacific.net.sg text/html
849881034.300 71790 202.42.208.182 TCP_MISS/200 84 GET
http://dspace.dial.pipex
.com/cgi-bin/nph-count?link=/town/parade/abk83/asian1.htm&show=NO -
DIRECT/dspac
e.dial.pipex.com image/gif
849881034.4105650 202.42.236.188 TCP_MISS/200 9266 GET http://home.earthlink.
net/~paperkites/fullad4.gif - PARENT_HIT/palo6.pacific.net.sg image/gif
849881034.560 72190 202.42.208.182 TCP_MISS/200 62826 GET
http://dspace.dial.pi
pex.com/elektra/pictures/asian1.jpg - PARENT_HIT/palo1.pacific.net.sg
image/jpeg
849881034.750 34850 202.42.236.243 TCP_MISS/200 36468 GET
http://www.cupids.co.
uk/validate/tiger1.jpg - PARENT_HIT/palo1.pacific.net.sg image/jpeg
849881034.750 34850 202.42.236.243 TCP_MISS/200 36468 GET
http://www.cupids.co.
uk/validate/tiger1.jpg - PARENT_HIT/palo1.pacific.net.sg image/jpeg
849881035.040 27350 202.42.236.247 TCP_MISS/200 11255 GET
http://albrecht.ecn.p
urdue.edu/~taylor/images/summer-95/ca_coast4-in.jpg -
PARENT_HIT/palo1.pacific.n
et.sg image/jpeg
849881035.1703070 202.42.236.210 TCP_MISS/404 836 GET http://www.xmission.com
/~hts/newban7.jpg - FIRST_PARENT_MISS/palo1.pacific.net.sg text/html
849881036.020 279920 202.42.236.199 TCP_MISS/200 45445 GET
http://www.bekkoame.o
r.jp/~annakazuki/102.jpg - FIRST_PARENT_MISS/palo1.pacific.net.sg image/jpeg
849881037.300 32960 202.42.236.200 TCP_MISS/200 11279 GET
http://www.onsale.com
/ - FIRST_PARENT_MISS/palo1.pacific.net.sg text/html
849881037.4909590 202.42.236.188 TCP_MISS/200 8776 GET http://home.earthlink.
net/~paperkites/fullad1.gif - FIRST_PARENT_MISS/palo1.pacific.net.sg image/gif
849881038.430 88240 202.42.236.211 TCP_MISS/200 78396 GET
http://www.info.fundp
.ac.be/~gga/hotpics/twinrock.jpg - FIRST_PARENT_MISS/palo1.pacific.net.sg
image/
jpeg
849881038.430 480 202.42.236.200 TCP_HIT/200 9634 GET http://www.onsale.com/n
ewgif/!onsale_.gif - NONE/- image/gif
849881038.500 510 202.42.236.200 TCP_HIT/200 895 GET http://www.onsale.com/ne
wgif/Service.gif - NONE/- image/gif
849881038.510 10800 202.42.236.188 TCP_MISS/200 7186 GET
http://home.earthlink.
net/~paperkites/miniad1.gif - FIRST_PARENT_MISS/palo6.pacific.net.sg image/gif
849881038.620 60 202.42.236.158 TCP_HIT/200 2568 GET http://www.windows95.co
m/gifs/w95com.gif - NONE/- image/gif
849881038.690 40 202.42.236.158 TCP_HIT/200 3960 GET http://www.windows95.co
m/gifs/vservers.gif - NONE/- image/gif
849881038.770 680 202.42.236.200 TCP_HIT/200 876 GET http://www.onsale.com/ne
wgif/b_about.gif - NONE/- image/gif
849881038.830 12670 202.42.236.212 TCP_MISS/200 15140 GET
http://www.nol.net/~r
edragon/index.shtml - FIRST_PARENT_MISS/palo6.pacific.net.sg text/html
849881038.940 450 202.42.236.200 TCP_HIT/200 781 GET http://www.onsale.com/ne
wgif/b_howto.gif - NONE/- image/gif
849881039.140 570 202.42.236.200 TCP_HIT/200 874 GET http://www.onsale.com/ne
wgif/b_format.gif - NONE/- image/gif
849881039.340 390 202.42.236.200 TCP_HIT/200 1000 GET
http://www.onsale.com/n
ewgif/!testimo.gif - NONE/- image/gif
849881039.540 210 202.42.236.200 TCP_HIT/200 2070 GET
http://www.onsale.com/b
lood/car.gif - NONE/- image/gif
849881039.740 220 202.42.236.200 TCP_HIT/200 2109 GET
http://www.onsale.com/n
ewgif/!categor.gif - NONE/- image/gif
849881203.780 500 203.120.85.61 TCP_DENIED/400 506 GET
http://www.geffen.com/
planetzombie/Images/511C001H.jpg - NONE/- -
849881204.900 2270 202.42.236.188 TCP_MISS/200 1417 GET
http://www.wax.or.jp/w
axmuseum/loverboy/home.html - PARENT_UDP_HIT_OBJ/palo6.pacific.net.sg text/html

Can somebody help me??? about a few 100 users are relying on this server :-(

shit... it died again... :-(

Thanks in advance
Walter
Received on Fri Dec 06 1996 - 06:21:40 MST

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