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

Hey Loïc,

I am not sure but a squid.conf will help a lot.
I want to make sure first:
are you using 150/192 squidguard helpers?
What have you tried to do?
Is this a regular forward proxy? is intercept proxy?
all these can be answered with squid.conf

Best regards,
Eliezer

On 1/7/2013 3:02 PM, Loïc Blot wrote:
> 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
>

-- 
Eliezer Croitoru
https://www1.ngtech.co.il
sip:ngtech_at_sip2sip.info
IT consulting for Nonprofit organizations
eliezer <at> ngtech.co.il