got some traces.

From: Dustin Byford <dustin@dont-contact.us>
Date: Wed, 15 Dec 1999 14:29:08 -0700

After messing with the DebugCache script I finally got something I think
may be usefull. I had to run gdb and type the commands to run and stack
trace squid by hand. I'm not sure why it didn't run when invoked from
the script. Squid was started at 11:32, here are the last bit of logs
and gdb output. There are a ton of "no data to process ((11) Resource
tempor..." throughout the log.

I have the rest of these log files and a core file if anyone is
interested.

On another note, I heard that wccp v2 was submitted by cisco to the
IETF, what does this mean for squid wccp?

Thanks for everyones help.

                        --Dustin

SQUID cache.log:
1999/12/15 12:33:26| clientReadRequest: FD 61: no data to process ((11)
Resource temporarily unavailable)
1999/12/15 12:33:26| storeCheckCachable: NO: too big
1999/12/15 12:33:26| clientReadRequest: FD 164: no data to process ((11)
Resource temporarily unavailable)
1999/12/15 12:33:26| The request GET
http://wwwheels.com:80/cars/a850406t.jpg is ALLOWED, because it matched
'allowed_hosts'
1999/12/15 12:33:26| clientReadRequest: FD 261: no data to process ((11)
Resource temporarily unavailable)
1999/12/15 12:33:26| clientReadRequest: FD 273: no data to process ((11)
Resource temporarily unavailable)
1999/12/15 12:33:26| The request GET
http://hg1.hitbox.com:80/HG?hc=w136&hb=CQ590914LCDZCXEN0&n=Main+Page&bn=Netscape&bv=301&ce=na&ss=na&sc=na&dt=12&sv=11&ja=y&rf=http%3A//nscp.snap.com/search/directory/results/1%2C61%2Cnscp-0%2C00.html%3Fkeyword%3Dpicpost.com%26tag%3Dtt.ns.sb1&ln=&pl=QuickTime%20Plug-In%3ANetscape%20Default%20Plugin%3ANPAVI32%20Dynamic%20Link%20Library%3ALiveAudio%3A&cd=1&jf=7
is ALLOWED, because it matched 'allowed_hosts'
1999/12/15 12:33:26| The request GET
http://voy14.voyeurweb.com:80/streams/eu10.jpg?isopen=1346776 is
ALLOWED, because it matched 'allowed_hosts'
1999/12/15 12:33:26| fwdServerClosed: FD 333
http://voy14.voyeurweb.com/streams/eu10.jpg?isopen=1464370
1999/12/15 12:33:26| The request GET
http://www.columbiahouse.com:80/m2/images/29/16/291690_1_60.jpg is
ALLOWED, because it matched 'allowed_hosts'
1999/12/15 12:33:26| clientReadRequest: FD 383: no data to process ((11)
Resource temporarily unavailable)
1999/12/15 12:33:26| The request GET
http://image.linkexchange.com:80/00/62/51/00/banner0x0.gif is ALLOWED,
because it matched 'allowed_hosts'
1999/12/15 12:33:26| fwdServerClosed: FD 449
http://voy14.voyeurweb.com/streams/eu10.jpg?isopen=1464369
1999/12/15 12:33:26| clientReadRequest: FD 468: no data to process ((11)
Resource temporarily unavailable)
1999/12/15 12:33:26| clientReadRequest: FD 482: no data to process ((11)
Resource temporarily unavailable)
1999/12/15 12:33:26| storeCheckCachable: NO: too big
1999/12/15 12:33:26| The request GET
http://www.apartments.com:80/images/nav_localnews_section.gif is
ALLOWED, because it matched 'allowed_hosts'
1999/12/15 12:33:26| clientReadRequest: FD 651: (32) Broken pipe
1999/12/15 12:33:26| fwdServerClosed: FD 678
http://206.111.160.139/FIDO-1/BID-1/NumItm-10/20121859-115036682
1999/12/15 12:33:26| The request GET
http://voy14.voyeurweb.com:80/streams/eu10.jpg?isopen=1346777 is
ALLOWED, because it matched 'allowed_hosts'
FATAL: Received Segment Violation...dying.
1999/12/15 14:08:43| storeDirWriteCleanLogs: Starting...
1999/12/15 14:09:51| Pinger exiting.

GDB command line:

Program received signal SIGSEGV, Segmentation fault.
0x2ab86f2a in _IO_vfprintf (s=0x0, format=0x2ac28ac6 "<%d>",
ap=0x7ffe78b8)
at vfprintf.c:1024
1024 vfprintf.c: No such file or directory.
(gdb) data to process ((11) Resource temporarily unavailable)
Undefined command: "data". Try "help".
(gdb) 1999/12/15 11:57:21| The request GET http://www.bedata to process
((11) Resource temporarily unavailable)
Undefined command: "1999". Try "help".
(gdb) 1999/12/15 11:57:21| The request GET http://www.bedata to process
((11) Resource temporarily unavailable)
Undefined command: "1999". Try "help".
(gdb) where
#0 0x2ab86f2a in _IO_vfprintf (s=0x0, format=0x2ac28ac6 "<%d>",
ap=0x7ffe78b8) at vfprintf.c:1024
#1 0x2ab8ef47 in fprintf (stream=0x0, format=0x2ac28ac6 "<%d>") at
fprintf.c:32
#2 0x2abef650 in vsyslog (pri=1, fmt=0x80be58b "%s", ap=0x7ffe7a7c) at
syslog.c:146
#3 0x2abef59f in syslog (pri=1, fmt=0x80be58b "%s") at syslog.c:106
#4 0x8091e04 in fatal_common (message=0x8170ea0 "xcalloc: Unable to
allocate 4096 blocks of 1 bytes!\n") at tools.c:306
#5 0x8091efa in fatal_dump (message=0x8170ea0 "xcalloc: Unable to
allocate
4096 blocks of 1 bytes!\n") at tools.c:369
#6 0x809e342 in xcalloc (n=4096, sz=1) at util.c:540
#7 0x805cbb1 in httpAccept (sock=15, data=0x7ffe7b50) at
client_side.c:2610
#8 0x805ebee in comm_check_incoming_poll_handlers (nfds=1,
fds=0x7ffe7bec)
at comm_select.c:240
#9 0x805edc2 in comm_poll_http_incoming () at comm_select.c:297
#10 0x805f5b0 in comm_poll (msec=0) at comm_select.c:491
#11 0x8077342 in main (argc=2, argv=0x7ffffcc4) at main.c:680

(gdb) bt
#0 0x2ab86f2a in _IO_vfprintf (s=0x0, format=0x2ac28ac6 "<%d>",
ap=0x7ffe78b8) at vfprintf.c:1024
#1 0x2ab8ef47 in fprintf (stream=0x0, format=0x2ac28ac6 "<%d>") at
fprintf.c:32
#2 0x2abef650 in vsyslog (pri=1, fmt=0x80be58b "%s", ap=0x7ffe7a7c) at
syslog.c:146
#3 0x2abef59f in syslog (pri=1, fmt=0x80be58b "%s") at syslog.c:106
#4 0x8091e04 in fatal_common (message=0x8170ea0 "xcalloc: Unable to
allocate 4096 blocks of 1 bytes!\n") at tools.c:306
#5 0x8091efa in fatal_dump (message=0x8170ea0 "xcalloc: Unable to
allocate
4096 blocks of 1 bytes!\n") at tools.c:369
#6 0x809e342 in xcalloc (n=4096, sz=1) at util.c:540
#7 0x805cbb1 in httpAccept (sock=15, data=0x7ffe7b50) at
client_side.c:2610
#8 0x805ebee in comm_check_incoming_poll_handlers (nfds=1,
fds=0x7ffe7bec)
at comm_select.c:240
#9 0x805edc2 in comm_poll_http_incoming () at comm_select.c:297
#10 0x805f5b0 in comm_poll (msec=0) at comm_select.c:491
#11 0x8077342 in main (argc=2, argv=0x7ffffcc4) at main.c:680
(gdb) c
Continuing.
1999/12/15 14:08:43| storeDirWriteCleanLogs: Starting...

Program received signal SIGSEGV, Segmentation fault.
0x2ab86f2a in _IO_vfprintf (s=0x0, format=0x2ac28ac6 "<%d>",
ap=0x7ffe6dec)
at vfprintf.c:1024
1024 in vfprintf.c
(gdb) bt
#0 0x2ab86f2a in _IO_vfprintf (s=0x0, format=0x2ac28ac6 "<%d>",
ap=0x7ffe6dec) at vfprintf.c:1024
#1 0x2ab8ef47 in fprintf (stream=0x0, format=0x2ac28ac6 "<%d>") at
fprintf.c:32
#2 0x2abef650 in vsyslog (pri=1, fmt=0x80be58b "%s", ap=0x7ffe6fb0) at
syslog.c:146
#3 0x2abef59f in syslog (pri=1, fmt=0x80be58b "%s") at syslog.c:106
#4 0x8091e04 in fatal_common (message=0x8170ea0 "xcalloc: Unable to
allocate 16384 blocks of 1 bytes!\n") at tools.c:306
#5 0x8091efa in fatal_dump (message=0x8170ea0 "xcalloc: Unable to
allocate
16384 blocks of 1 bytes!\n") at tools.c:369
#6 0x809e342 in xcalloc (n=16384, sz=1) at util.c:540
#7 0x808f03f in storeUfsDirWriteCleanOpen (sd=0x820c428) at
store_dir_ufs.c:828
#8 0x808d693 in storeDirWriteCleanLogs (reopen=0) at store_dir.c:398
#9 0x8091d60 in death (sig=11) at tools.c:263
#10 0x2aaf7522 in pthread_sighandler (signo=11, ctx={gs = 0, __gsh = 0,
fs =
0, __fsh = 0, es = 43, __esh = 0, ds = 43, __dsh = 0, edi = 0, esi =
717426656, ebp = 2147383440,
      esp = 2147381764, ebx = 717423756, edx = 0, ecx = 135015872, eax =
12,
trapno = 14, err = 4, eip = 716730154, cs = 35, __csh = 0, eflags =
66050,
esp_at_signal = 2147381764, ss = 43,
      __ssh = 0, fpstate = 0x7ffe7188, oldmask = 2147483648, cr2 = 0})
at
signals.c:91
#11 0x2ab60408 in __restore () at
../sysdeps/unix/sysv/linux/i386/sigaction.c:127
#12 0x2ab8ef47 in fprintf (stream=0x0, format=0x2ac28ac6 "<%d>") at
fprintf.c:32
#13 0x2abef650 in vsyslog (pri=1, fmt=0x80be58b "%s", ap=0x7ffe7a7c) at
syslog.c:146
#14 0x2abef59f in syslog (pri=1, fmt=0x80be58b "%s") at syslog.c:106
#15 0x8091e04 in fatal_common (message=0x8170ea0 "xcalloc: Unable to
allocate 16384 blocks of 1 bytes!\n") at tools.c:306
#16 0x8091efa in fatal_dump (message=0x8170ea0 "xcalloc: Unable to
allocate
16384 blocks of 1 bytes!\n") at tools.c:369
#17 0x809e342 in xcalloc (n=4096, sz=1) at util.c:540
#18 0x805cbb1 in httpAccept (sock=15, data=0x7ffe7b50) at
client_side.c:2610
#19 0x805ebee in comm_check_incoming_poll_handlers (nfds=1,
fds=0x7ffe7bec)
at comm_select.c:240
#20 0x805edc2 in comm_poll_http_incoming () at comm_select.c:297
#21 0x805f5b0 in comm_poll (msec=0) at comm_select.c:491
#22 0x8077342 in main (argc=2, argv=0x7ffffcc4) at main.c:680

(gdb) c
Continuing.
Error accessing memory address 0x2aafe874: No such process.
(gdb) bt
#0 0x2ab86f2a in _IO_vfprintf (s=Error accessing memory address
0x7ffe6dcc:
No such process.
) at vfprintf.c:1024
#1 0x2ab8ef47 in fprintf (stream=Error accessing memory address
0x7ffe6de4:
No such process.
) at fprintf.c:32
#2 0x2abef650 in vsyslog (pri=Error accessing memory address
0x7ffe6f90: No
such process.
) at syslog.c:146
#3 0x2abef59f in syslog (pri=Error accessing memory address 0x7ffe6fa8:
No
such process.
) at syslog.c:106
#4 0x8091e04 in fatal_common (message=Error accessing memory address
0x7ffe6fc0: No such process.
) at tools.c:306
#5 0x8091efa in fatal_dump (message=Error accessing memory address
0x7ffe6fd0: No such process.
) at tools.c:369
#6 0x809e342 in xcalloc (n=Error accessing memory address 0x7ffe6ff8:
No
such process.
) at util.c:540
#7 0x808f03f in storeUfsDirWriteCleanOpen (sd=Error accessing memory
address 0x7ffe7074: No such process.
) at store_dir_ufs.c:828
#8 0x808d693 in storeDirWriteCleanLogs (reopen=Error accessing memory
address 0x7ffe70a8: No such process.
) at store_dir.c:398
#9 0x8091d60 in death (sig=Error accessing memory address 0x7ffe70b4:
No
such process.
) at tools.c:263
#10 0x2aaf7522 in pthread_sighandler (signo=Error accessing memory
address
0x7ffe712c: No such process.
) at signals.c:91
#11 0x2ab60408 in __restore () at
../sysdeps/unix/sysv/linux/i386/sigaction.c:127
#12 0x2ab8ef47 in fprintf (stream=Error accessing memory address
0x7ffe78b0:
No such process.
) at fprintf.c:32
#13 0x2abef650 in vsyslog (pri=Error accessing memory address
0x7ffe7a5c: No
such process.
) at syslog.c:146
#14 0x2abef59f in syslog (pri=Error accessing memory address 0x7ffe7a74:
No
such process.
) at syslog.c:106
#15 0x8091e04 in fatal_common (message=Error accessing memory address
0x7ffe7a8c: No such process.
) at tools.c:306
#16 0x8091efa in fatal_dump (message=Error accessing memory address
0x7ffe7a9c: No such process.
) at tools.c:369
#17 0x809e342 in xcalloc (n=Error accessing memory address 0x7ffe7ac4:
No
such process.
) at util.c:540
#18 0x805cbb1 in httpAccept (sock=Error accessing memory address
0x7ffe7b14:
No such process.
) at client_side.c:2610
#19 0x805ebee in comm_check_incoming_poll_handlers (nfds=Error accessing
memory address 0x7ffe7bd4: No such process.
) at comm_select.c:240
#20 0x805edc2 in comm_poll_http_incoming () at comm_select.c:297
#21 0x805f5b0 in comm_poll (msec=Error accessing memory address
0x7ffffc6c:
No such process.
) at comm_select.c:491
#22 0x8077342 in main (argc=Error accessing memory address 0x7ffffc80:
No
such process.
) at main.c:680
Error accessing memory address 0x7ffffc78: No such process.
Received on Wed Dec 15 1999 - 13:34:10 MST

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