Re: [squid-users] Squid crash on OpenBSD 5.2

Here is the backtrace:
#0 0x0000000206a8ebca in kill () from /usr/lib/libc.so.65.0
#1 0x0000000206af5791 in abort ()
at /usr/src/lib/libc/stdlib/abort.c:68
#2 0x0000000206a72e84 in __assert2 (file=Variable "file" is not
available.
) at /usr/src/lib/libc/gen/assert.c:52
#3 0x000000000066161c in Ip::Address::GetAddrInfo (this=0x208d7c008,
dst=@0x10, force=0) at Address.cc:689
#4 0x000000000065b5a6 in comm_openex (sock_type=1, proto=6,
addr=@0x208d7c008, flags=1, tos=0 '\0', nfmark=0, note=0x20efc56e0
"localhost.institutoptique.fr") at comm.cc:525
#5 0x00000000006b8bec in Comm::ConnOpener::start (this=0x2077e5e98) at
ConnOpener.cc:164
#6 0x0000000000650198 in JobDialer<AsyncJob>::dial (this=0x203c5d130,
call=@0x203c5d100) at AsyncJobCalls.h:175
#7 0x000000000064d0ca in AsyncCall::make (this=0x203c5d100) at
AsyncCall.cc:36
#8 0x00000000006509c4 in AsyncCallQueue::fireNext (this=0x20ead5a60) at
AsyncCallQueue.cc:54
#9 0x0000000000650b8f in AsyncCallQueue::fire (this=0x20ead5a60) at
AsyncCallQueue.cc:40
#10 0x0000000000514551 in EventLoop::dispatchCalls (this=Variable "this"
is not available.
) at EventLoop.cc:154
#11 0x00000000005147fd in EventLoop::runOnce (this=0x7f7ffffca3c0) at
EventLoop.cc:131
#12 0x00000000005149a8 in EventLoop::run (this=0x7f7ffffca3c0) at
EventLoop.cc:95
#13 0x000000000058a243 in SquidMain (argc=4, argv=Variable "argv" is not
available.
) at main.cc:1501
#14 0x000000000058a5a8 in SquidMainSafe (argc=Variable "argc" is not
available.
) at main.cc:1216
#15 0x00000000004a5301 in ___start ()
#16 0x0000000000000004 in ?? ()
#17 0x00007f7ffffca630 in ?? ()
#18 0x00007f7ffffca64c in ?? ()
#19 0x00007f7ffffca64f in ?? ()
#20 0x00007f7ffffca652 in ?? ()
#21 0x0000000000000000 in ?? ()

-- 
Best regards, 
Loïc BLOT, Engineering
UNIX Systems, Security and Networks
http://www.unix-experience.fr
Le lundi 07 janvier 2013 à 14:02 +0100, Loïc Blot a écrit :
> Hello,
> i get crashes since migrating from Squid 3.1.22 to Squid 3.2.5 last
> week. In 3.1.22 there are less crashes :s.
> 
> I want to use 3.2.X to improve the functionnalities. Squid is configured
> with SquidGuard.
> 
> Do you have an idea ?
> 
> Here are the logs:
> 
> Page faults with physical i/o: 0
> 2013/01/07 13:52:11 kid1| Starting Squid Cache version 3.2.5 for
> amd64-unknown-openbsd5.2...
> 2013/01/07 13:52:11 kid1| Process ID 5577
> 2013/01/07 13:52:11 kid1| Process Roles: worker
> 2013/01/07 13:52:11 kid1| With 4096 file descriptors available
> 2013/01/07 13:52:11 kid1| Initializing IP Cache...
> 2013/01/07 13:52:11 kid1| DNS Socket created at 0.0.0.0, FD 6
> 2013/01/07 13:52:11 kid1| Adding nameserver 127.0.0.1
> from /etc/resolv.conf
> 2013/01/07 13:52:11 kid1| helperOpenServers: Starting 150/192
> 'squidGuard' processes
> 2013/01/07 13:52:12 kid1| Logfile: opening log /var/log/squid/access.log
> 2013/01/07 13:52:12 kid1| WARNING: log parameters now start with a
> module name. Use 'stdio:/var/log/squid/access.log'
> 2013/01/07 13:52:12 kid1| Unlinkd pipe opened on FD 311
> 2013/01/07 13:52:12 kid1| Store logging disabled
> 2013/01/07 13:52:12 kid1| Swap maxSize 2867200 + 2867200 KB, estimated
> 441107 objects
> 2013/01/07 13:52:12 kid1| Target number of buckets: 22055
> 2013/01/07 13:52:12 kid1| Using 32768 Store buckets
> 2013/01/07 13:52:12 kid1| Max Mem  size: 2867200 KB
> 2013/01/07 13:52:12 kid1| Max Swap size: 2867200 KB
> 2013/01/07 13:52:12 kid1| Rebuilding storage in /var/squid/cache (clean
> log)
> 2013/01/07 13:52:12 kid1| Using Least Load store dir selection
> 2013/01/07 13:52:12 kid1| Set Current Directory to /var/squid/cache
> 2013/01/07 13:52:12 kid1| Loaded Icons.
> 2013/01/07 13:52:12 kid1| commBind: Cannot bind socket FD 315 to
> 0.0.0.0:3128: (48) Address already in use
> 2013/01/07 13:52:12 kid1| HTCP Disabled.
> 2013/01/07 13:52:12 kid1| Squid plugin modules loaded: 0
> 2013/01/07 13:52:12 kid1| Accepting HTTP Socket connections at
> local=0.0.0.0:3128 remote=[::] FD 314 flags=9
> 2013/01/07 13:52:12 kid1| Store rebuilding is 5.98% complete
> 2013/01/07 13:52:12 kid1| Failed to select source for
> 'http://shijie.institutoptique.fr/'
> 2013/01/07 13:52:12 kid1|   always_direct = 0
> 2013/01/07 13:52:12 kid1|    never_direct = 0
> 2013/01/07 13:52:12 kid1|        timedout = 0
> 2013/01/07 13:52:12 kid1| Done reading /var/squid/cache swaplog (66864
> entries)
> 2013/01/07 13:52:12 kid1| Finished rebuilding storage from disk.
> 2013/01/07 13:52:12 kid1|     66863 Entries scanned
> 2013/01/07 13:52:12 kid1|         1 Invalid entries.
> 2013/01/07 13:52:12 kid1|         0 With invalid flags.
> 2013/01/07 13:52:12 kid1|     66863 Objects loaded.
> 2013/01/07 13:52:12 kid1|         0 Objects expired.
> 2013/01/07 13:52:12 kid1|         0 Objects cancelled.
> 2013/01/07 13:52:12 kid1|         0 Duplicate URLs purged.
> 2013/01/07 13:52:12 kid1|         0 Swapfile clashes avoided.
> 2013/01/07 13:52:12 kid1|   Took 0.33 seconds (200209.60 objects/sec).
> 2013/01/07 13:52:12 kid1| Beginning Validation Procedure
> 2013/01/07 13:52:12 kid1|   Completed Validation Procedure
> 2013/01/07 13:52:12 kid1|   Validated 66863 Entries
> 2013/01/07 13:52:12 kid1|   store_swap_size = 2582071.00 KB
> 2013/01/07 13:52:13 kid1| storeLateRelease: released 0 objects
> 2013/01/07 13:52:14 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:14 kid1|   always_direct = 0
> 2013/01/07 13:52:14 kid1|    never_direct = 0
> 2013/01/07 13:52:14 kid1|        timedout = 0
> 2013/01/07 13:52:15 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:15 kid1|   always_direct = 0
> 2013/01/07 13:52:15 kid1|    never_direct = 0
> 2013/01/07 13:52:15 kid1|        timedout = 0
> 2013/01/07 13:52:16 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:16 kid1|   always_direct = 0
> 2013/01/07 13:52:16 kid1|    never_direct = 0
> 2013/01/07 13:52:16 kid1|        timedout = 0
> 2013/01/07 13:52:17 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:17 kid1|   always_direct = 0
> 2013/01/07 13:52:17 kid1|    never_direct = 0
> 2013/01/07 13:52:17 kid1|        timedout = 0
> 2013/01/07 13:52:17 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:17 kid1|   always_direct = 0
> 2013/01/07 13:52:17 kid1|    never_direct = 0
> 2013/01/07 13:52:17 kid1|        timedout = 0
> 2013/01/07 13:52:17 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:17 kid1|   always_direct = 0
> 2013/01/07 13:52:17 kid1|    never_direct = 0
> 2013/01/07 13:52:17 kid1|        timedout = 0
> 2013/01/07 13:52:18 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:18 kid1|   always_direct = 0
> 2013/01/07 13:52:18 kid1|    never_direct = 0
> 2013/01/07 13:52:18 kid1|        timedout = 0
> 2013/01/07 13:52:21 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:21 kid1|   always_direct = 0
> 2013/01/07 13:52:21 kid1|    never_direct = 0
> 2013/01/07 13:52:21 kid1|        timedout = 0
> 2013/01/07 13:52:21 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:21 kid1|   always_direct = 0
> 2013/01/07 13:52:21 kid1|    never_direct = 0
> 2013/01/07 13:52:21 kid1|        timedout = 0
> 2013/01/07 13:52:22 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:22 kid1|   always_direct = 0
> 2013/01/07 13:52:22 kid1|    never_direct = 0
> 2013/01/07 13:52:22 kid1|        timedout = 0
> 2013/01/07 13:52:24 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:24 kid1|   always_direct = 0
> 2013/01/07 13:52:24 kid1|    never_direct = 0
> 2013/01/07 13:52:24 kid1|        timedout = 0
> 2013/01/07 13:52:24 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:24 kid1|   always_direct = 0
> 2013/01/07 13:52:24 kid1|    never_direct = 0
> 2013/01/07 13:52:24 kid1|        timedout = 0
> 2013/01/07 13:52:24 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:24 kid1|   always_direct = 0
> 2013/01/07 13:52:24 kid1|    never_direct = 0
> 2013/01/07 13:52:24 kid1|        timedout = 0
> 2013/01/07 13:52:25 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:25 kid1|   always_direct = 0
> 2013/01/07 13:52:25 kid1|    never_direct = 0
> 2013/01/07 13:52:25 kid1|        timedout = 0
> 2013/01/07 13:52:26 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:26 kid1|   always_direct = 0
> 2013/01/07 13:52:26 kid1|    never_direct = 0
> 2013/01/07 13:52:26 kid1|        timedout = 0
> 2013/01/07 13:52:27 kid1| ipcacheParse: No Address records in response
> to 'ipv6.msftncsi.com'
> 2013/01/07 13:52:27 kid1| ipcacheParse: No Address records in response
> to 'ipv6.msftncsi.com'
> 2013/01/07 13:52:27 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:27 kid1|   always_direct = 0
> 2013/01/07 13:52:27 kid1|    never_direct = 0
> 2013/01/07 13:52:27 kid1|        timedout = 0
> 2013/01/07 13:52:27 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:27 kid1|   always_direct = 0
> 2013/01/07 13:52:27 kid1|    never_direct = 0
> 2013/01/07 13:52:27 kid1|        timedout = 0
> 2013/01/07 13:52:27 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:27 kid1|   always_direct = 0
> 2013/01/07 13:52:27 kid1|    never_direct = 0
> 2013/01/07 13:52:27 kid1|        timedout = 0
> 2013/01/07 13:52:29 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:29 kid1|   always_direct = 0
> 2013/01/07 13:52:29 kid1|    never_direct = 0
> 2013/01/07 13:52:29 kid1|        timedout = 0
> FATAL: Received Bus Error...dying.
> 2013/01/07 13:52:41 kid1| Closing HTTP port 0.0.0.0:3128
> 2013/01/07 13:52:41 kid1| Closing HTTP port 0.0.0.0:3128
> 2013/01/07 13:52:41 kid1| storeDirWriteCleanLogs: Starting...
> 2013/01/07 13:52:42 kid1|     65536 entries written so far.
> 2013/01/07 13:52:42 kid1|   Finished.  Wrote 66957 entries.
> 2013/01/07 13:52:42 kid1|   Took 0.02 seconds (4130088.82 entries/sec).
> CPU Usage: 4.250 seconds = 1.260 user + 2.990 sys
> Maximum Resident Size: 53180 KB
> Page faults with physical i/o: 0
> 2013/01/07 13:52:45 kid1| Starting Squid Cache version 3.2.5 for
> amd64-unknown-openbsd5.2...
> 2013/01/07 13:52:45 kid1| Process ID 25866
> 2013/01/07 13:52:45 kid1| Process Roles: worker
> 2013/01/07 13:52:45 kid1| With 4096 file descriptors available
> 2013/01/07 13:52:45 kid1| Initializing IP Cache...
> 2013/01/07 13:52:45 kid1| DNS Socket created at 0.0.0.0, FD 6
> 2013/01/07 13:52:45 kid1| Adding nameserver 127.0.0.1
> from /etc/resolv.conf
> 2013/01/07 13:52:45 kid1| helperOpenServers: Starting 150/192
> 'squidGuard' processes
> 2013/01/07 13:52:46 kid1| Logfile: opening log /var/log/squid/access.log
> 2013/01/07 13:52:46 kid1| WARNING: log parameters now start with a
> module name. Use 'stdio:/var/log/squid/access.log'
> 2013/01/07 13:52:46 kid1| Unlinkd pipe opened on FD 311
> 2013/01/07 13:52:46 kid1| Store logging disabled
> 2013/01/07 13:52:46 kid1| Swap maxSize 2867200 + 2867200 KB, estimated
> 441107 objects
> 2013/01/07 13:52:46 kid1| Target number of buckets: 22055
> 2013/01/07 13:52:46 kid1| Using 32768 Store buckets
> 2013/01/07 13:52:46 kid1| Max Mem  size: 2867200 KB
> 2013/01/07 13:52:46 kid1| Max Swap size: 2867200 KB
> 2013/01/07 13:52:46 kid1| Rebuilding storage in /var/squid/cache (clean
> log)
> 2013/01/07 13:52:46 kid1| Using Least Load store dir selection
> 2013/01/07 13:52:46 kid1| Set Current Directory to /var/squid/cache
> 2013/01/07 13:52:46 kid1| Loaded Icons.
> 2013/01/07 13:52:46 kid1| commBind: Cannot bind socket FD 315 to
> 0.0.0.0:3128: (48) Address already in use
> 2013/01/07 13:52:46 kid1| HTCP Disabled.
> 2013/01/07 13:52:46 kid1| Squid plugin modules loaded: 0
> 2013/01/07 13:52:46 kid1| Accepting HTTP Socket connections at
> local=0.0.0.0:3128 remote=[::] FD 314 flags=9
> 2013/01/07 13:52:46 kid1| Store rebuilding is 5.97% complete
> 2013/01/07 13:52:46 kid1| Done reading /var/squid/cache swaplog (66957
> entries)
> 2013/01/07 13:52:46 kid1| Finished rebuilding storage from disk.
> 2013/01/07 13:52:46 kid1|     66957 Entries scanned
> 2013/01/07 13:52:46 kid1|         0 Invalid entries.
> 2013/01/07 13:52:46 kid1|         0 With invalid flags.
> 2013/01/07 13:52:46 kid1|     66957 Objects loaded.
> 2013/01/07 13:52:46 kid1|         0 Objects expired.
> 2013/01/07 13:52:46 kid1|         0 Objects cancelled.
> 2013/01/07 13:52:46 kid1|         0 Duplicate URLs purged.
> 2013/01/07 13:52:46 kid1|         0 Swapfile clashes avoided.
> 2013/01/07 13:52:46 kid1|   Took 0.34 seconds (196973.49 objects/sec).
> 2013/01/07 13:52:46 kid1| Beginning Validation Procedure
> 2013/01/07 13:52:46 kid1|   Completed Validation Procedure
> 2013/01/07 13:52:46 kid1|   Validated 66957 Entries
> 2013/01/07 13:52:46 kid1|   store_swap_size = 2579500.00 KB
> 2013/01/07 13:52:47 kid1| storeLateRelease: released 0 objects
> 2013/01/07 13:52:48 kid1| ipcacheParse: No Address records in response
> to 'ipv6.msftncsi.com'
> 2013/01/07 13:52:48 kid1| ipcacheParse: No Address records in response
> to 'ipv6.msftncsi.com'
> 2013/01/07 13:52:48 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:48 kid1|   always_direct = 0
> 2013/01/07 13:52:48 kid1|    never_direct = 0
> 2013/01/07 13:52:48 kid1|        timedout = 0
> 2013/01/07 13:52:49 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:49 kid1|   always_direct = 0
> 2013/01/07 13:52:49 kid1|    never_direct = 0
> 2013/01/07 13:52:49 kid1|        timedout = 0
> 2013/01/07 13:52:50 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:52:50 kid1|   always_direct = 0
> 2013/01/07 13:52:50 kid1|    never_direct = 0
> 2013/01/07 13:52:50 kid1|        timedout = 0
> 2013/01/07 13:53:11 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:53:11 kid1|   always_direct = 0
> 2013/01/07 13:53:11 kid1|    never_direct = 0
> 2013/01/07 13:53:11 kid1|        timedout = 0
> 2013/01/07 13:53:26 kid1| Failed to select source for '[null_entry]'
> 2013/01/07 13:53:26 kid1|   always_direct = 0
> 2013/01/07 13:53:26 kid1|    never_direct = 0
> 2013/01/07 13:53:26 kid1|        timedout = 0
> FATAL: Received Segment Violation...dying.
> 2013/01/07 13:53:35 kid1| Closing HTTP port 0.0.0.0:3128
> 2013/01/07 13:53:35 kid1| Closing HTTP port 0.0.0.0:3128
> 2013/01/07 13:53:35 kid1| storeDirWriteCleanLogs: Starting...
> 2013/01/07 13:53:35 kid1|     65536 entries written so far.
> 2013/01/07 13:53:35 kid1|   Finished.  Wrote 67222 entries.
> 2013/01/07 13:53:35 kid1|   Took 0.02 seconds (4038084.94 entries/sec).
> CPU Usage: 6.710 seconds = 1.600 user + 5.110 sys
> Maximum Resident Size: 69424 KB
> Page faults with physical i/o: 0
>