Squid Crashing On Log Rotation

LostInIgnorance · Feb 15, 2015, 2:54 PM

I have 2.2 x64 installed with squid 3. I have found there is a bug where every night it seems to look to find what the size of the cached content is. From there it says it exceeds the size (which it doesn't 4752 bytes does not equal 20GB). It then trys to rotate the files and doesn't succeed in restarting or creating these files. Seems to happen every night at midnight.

Feb 15 00:00:00 	php: swapstate_check.php: Creating Squid cache dir /var/squid/cache
Feb 15 00:00:00 	php: swapstate_check.php: Creating squid cache subdirs in /var/squid/cache
Feb 15 00:00:00 	squid[97848]: Squid Parent: (squid-1) process 98244 exited due to signal 6 with status 0
Feb 15 00:00:00 	kernel: pid 98244 (squid), uid 62: exited on signal 6
Feb 15 00:00:03 	squid[97848]: Squid Parent: (squid-1) process 2778 started
Feb 15 00:00:04 	(squid-1): Failed to verify one of the swap directories, Check cache.log for details. Run 'squid -z' to create swap directories if needed, or if running Squid for the first time.
Feb 15 00:00:04 	squid[97848]: Squid Parent: (squid-1) process 2778 exited with status 1
Feb 15 00:00:05 	php: swapstate_check.php: The command '/usr/pbi/squid-amd64/sbin/squid -k kill -f /usr/pbi/squid-amd64/local/etc/squid/squid.conf' returned exit code '1', the output was 'squid: ERROR: Could not send signal 9 to process 98244: (3) No such process'
Feb 15 00:00:05 	squid[18420]: Squid Parent: will start 1 kids
Feb 15 00:00:05 	squid[18420]: Squid Parent: (squid-1) process 18919 started
Feb 15 00:00:07 	squid[97848]: Squid Parent: (squid-1) process 19783 started
Feb 15 00:00:07 	(squid-1): Failed to verify one of the swap directories, Check cache.log for details. Run 'squid -z' to create swap directories if needed, or if running Squid for the first time.
Feb 15 00:00:07 	squid[97848]: Squid Parent: (squid-1) process 19783 exited with status 1
Feb 15 00:00:10 	squid[97848]: Squid Parent: (squid-1) process 20270 started
Feb 15 00:00:11 	(squid-1): Failed to verify one of the swap directories, Check cache.log for details. Run 'squid -z' to create swap directories if needed, or if running Squid for the first time.
Feb 15 00:00:11 	squid[97848]: Squid Parent: (squid-1) process 20270 exited with status 1
Feb 15 00:00:14 	squid[97848]: Squid Parent: (squid-1) process 20755 started
Feb 15 00:00:14 	(squid-1): Failed to verify one of the swap directories, Check cache.log for details. Run 'squid -z' to create swap directories if needed, or if running Squid for the first time.
Feb 15 00:00:14 	squid[97848]: Squid Parent: (squid-1) process 20755 exited with status 1
Feb 15 00:00:17 	squid[97848]: Squid Parent: (squid-1) process 30642 started
Feb 15 00:00:17 	(squid-1): Failed to verify one of the swap directories, Check cache.log for details. Run 'squid -z' to create swap directories if needed, or if running Squid for the first time.
Feb 15 00:00:17 	squid[97848]: Squid Parent: (squid-1) process 30642 exited with status 1
Feb 15 00:00:17 	squid[97848]: Squid Parent: (squid-1) process 30642 will not be restarted due to repeated, frequent failures
Feb 15 00:00:17 	squid[97848]: Exiting due to repeated, frequent failures
Feb 15 00:00:19 	Squid_Alarm[32316]: Squid has exited. Reconfiguring filter.
Feb 15 00:00:19 	Squid_Alarm[32498]: Attempting restart...
Feb 15 00:00:23 	Squid_Alarm[33903]: Reconfiguring filter...
Feb 15 00:00:23 	check_reload_status: Reloading filter
Feb 15 00:00:44 	squid[18420]: Squid Parent: (squid-1) process 18919 exited with status 0
Feb 15 00:00:44 	php: swapstate_check.php: Squid cache and/or swap.state exceeded size limits. Removing and rotating. File was 4752 bytes, 0% of total disk space.

I have uninstalled and deleted everything from /var/squid and then reinstalled with no luck.

LostInIgnorance · Mar 8, 2015, 9:21 PM

It seems to be some error in the nightly script that runs for log rotation. I have found it only errors out when the "Clear cache on log rotate" is checked. Does anyone have any incite into this nightly job?

sujyo1 · Mar 16, 2015, 6:58 AM

2.2-RELEASE (i386)
built on Thu Jan 22 14:04:25 CST 2015
FreeBSD 10.1-RELEASE-p4

Intel(R) Core(TM)2 Duo CPU E4500 @ 2.20GHz
2 CPUs: 1 package(s) x 2 core(s)

Install pkgs: squid3 (Transparent HTTP proxy enable, c-icap&clamd disable), corn, sarg

log:
Mar 16 00:00:13 squid[88317]: Squid Parent: (squid-1) process 92076 started
Mar 16 00:00:12 php: swapstate_check.php: Squid cache and/or swap.state exceeded size limits. Removing and rotating. File was 3891776 bytes, 0% of total disk space.
Mar 16 00:00:12 squid[86533]: Squid Parent: (squid-1) process 86945 exited with status 0
Mar 16 00:00:10 squid[88317]: Squid Parent: (squid-1) process 87786 exited with status 1
Mar 16 00:00:10 (squid-1): Failed to verify one of the swap directories, Check cache.log for details. Run 'squid -z' to create swap directories if needed, or if running Squid for the first time.
Mar 16 00:00:10 squid[88317]: Squid Parent: (squid-1) process 87786 started
Mar 16 00:00:07 squid[88317]: Squid Parent: (squid-1) process 87478 exited with status 1
Mar 16 00:00:07 (squid-1): Failed to verify one of the swap directories, Check cache.log for details. Run 'squid -z' to create swap directories if needed, or if running Squid for the first time.
Mar 16 00:00:06 squid[88317]: Squid Parent: (squid-1) process 87478 started
Mar 16 00:00:05 squid[86533]: Squid Parent: (squid-1) process 86945 started
Mar 16 00:00:05 squid[86533]: Squid Parent: will start 1 kids
Mar 16 00:00:05 php: swapstate_check.php: The command '/usr/pbi/squid-i386/sbin/squid -k kill -f /usr/pbi/squid-i386/local/etc/squid/squid.conf' returned exit code '1', the output was 'squid: ERROR: Could not send signal 9 to process 13758: (3) No such process'
Mar 16 00:00:03 squid[88317]: Squid Parent: (squid-1) process 80899 exited with status 1
Mar 16 00:00:03 (squid-1): Failed to verify one of the swap directories, Check cache.log for details. Run 'squid -z' to create swap directories if needed, or if running Squid for the first time.
Mar 16 00:00:03 squid[88317]: Squid Parent: (squid-1) process 80899 started
Mar 16 00:00:00 kernel: pid 13758 (squid), uid 62: exited on signal 6
Mar 16 00:00:00 php: swapstate_check.php: Creating squid cache subdirs in /var/squid/cache
Mar 16 00:00:00 php: sarg.php: Sarg: force refresh now with -d date +%d/%m/%Y-date +%d/%m/%Y args, compress(on) and none action after sarg finish.
Mar 16 00:00:00 php: swapstate_check.php: Creating Squid cache dir /var/squid/cache
Mar 16 00:00:00 php: sarg.php: Sarg: force refresh now with -d date +%d/%m/%Y-date +%d/%m/%Y args, compress(on) and none action after sarg finish.
Mar 15 23:00:00 php: sarg.php: Sarg: force refresh now with -d date +%d/%m/%Y-date +%d/%m/%Y args, compress(on) and none action after sarg finish.
Mar 15 22:00:00 php: sarg.php: Sarg: force refresh now with -d date +%d/%m/%Y-date +%d/%m/%Y args, compress(on) and none action after sarg finish.
Mar 15 21:00:00 php: sarg.php: Sarg: force refresh now with -d date +%d/%m/%Y-date +%d/%m/%Y args, compress(on) and none action after sarg finish.
Mar 15 20:00:00 php: sarg.php: Sarg: force refresh now with -d date +%d/%m/%Y-date +%d/%m/%Y args, compress(on) and none action after sarg finish.
Mar 15 19:29:41 kernel: arp: xxx.xx.xx.1 moved from 00:17:10:89:12:60 to 00:17:10:89:10:20 on em2
Mar 15 19:29:38 kernel: arp: xxx.xx.xx.1 moved from 00:17:10:89:10:20 to 00:17:10:89:12:60 on em2
Mar 15 19:29:34 kernel: arp: xxx.xx.xx.1 moved from 00:17:10:89:12:60 to 00:17:10:89:10:20 on em2
Mar 15 19:29:31 kernel: arp: xxx.xx.xx.1 moved from 00:17:10:89:12:60 to 00:17:10:89:10:20 on em2
Mar 15 19:00:00 php: sarg.php: Sarg: force refresh now with -d date +%d/%m/%Y-date +%d/%m/%Y args, compress(on) and none action after sarg finish.
Mar 15 18:00:00 php: sarg.php: Sarg: force refresh now with -d date +%d/%m/%Y-date +%d/%m/%Y args, compress(on) and none action after sarg finish.