[squid-users] basic authenticator hangs when squid often receive logrotate

From: Anton Golubev <anton@dont-contact.us>
Date: Mon, 10 Jan 2005 00:44:20 +0300

Hello, colleagues!

I have trouble with basic authenticator daemons. They are hanging and
use can't authenticate himself anymore. After a while I have this in my
statistics:

Basic Authenticator Statistics:
program: /usr/local/bin/user_auth
number running: 11 of 5
requests sent: 2808
replies received: 2802
queue length: 0
avg service time: 95.88 msec

# FD PID # Requests Flags Time Offset Request
2 33 90292 2 AB S 130031.644 0
nsokolova2 xxxx\n
2 36 90615 2 AB S 123530.990 0 mknyish
xxxx\n
1 26 93367 5 AB S 66203.355 0 stepa
xxxx\n
1 29 93656 3 AB S 58148.235 0 stepa
xxxx\n
1 28 94210 2 AB S 45955.031 0
ibarabash xxxx\n
1 34 94701 22 AB S 35611.662 0
ibarabash xxxx\n
1 41 96230 57 A 0.097 0 (none)
2 42 96231 0 A 0.000 0 (none)
3 43 96232 0 A 0.000 0 (none)
4 44 96233 0 A 0.000 0 (none)
5 48 96234 0 A 0.000 0 (none)

Debug 84, 5 in squid.conf shows:

2005/01/09 02:00:00| helperShutdown: basicauthenticator #2 is BUSY.
2005/01/09 02:00:00| helperShutdown: basicauthenticator #2 is BUSY.
2005/01/09 02:00:00| storeDirWriteCleanLogs: Starting...

2005/01/09 04:00:00| helperShutd own: basicauthenticator #2 is
BUSY.
2005/01/09 04:00:00| helperShutdown: basicauthenticator #2 is BUSY.
2005/01/09 04:00:00| storeDirWriteCleanLogs: Starting...

2005/01/09 06:00:01| helperShutdown: basicauthenticator #2 is BUSY.
2005/01/09 06:00:01| helperShutdown: basicauthenticator #2 is BUSY.
2005/01/09 06:00:01| helperShutdown: basicauthenticator #1 is BUSY.
2005/01/09 06:00:01| storeDirWriteCleanLogs: Starting...

And so on...

My opinion is has "hanging" of authenticator occurs just after receiving
"squid logrotate" signal (which is done each 2 hours via cron for rapid
log processing).

Please, don't suspect authenticator itself. It exists more then 2 years
already without single problem (simple SELECT -> compare c-program).

I also think that only recent change in my system, which could trigger
the problem is decreasing "squid logrotate" period from 24 to 2 hours.

Some statistics:

Squid Object Cache: Version 2.5.STABLE5
Start Time: Fri, 07 Jan 2005 14:20:17 GMT
Current Time: Sun, 09 Jan 2005 21:37:22 GMT

apfel# uname -a
FreeBSD apfel.engec.ru 5.2.1-RELEASE-p8 FreeBSD 5.2.1-RELEASE-p8 #1: Tue
Jun 15 00:18:07 MSD 2004
root@apfel.engec.ru:/usr/src/sys/i386/compile/APFEL i386

Kernel is uniprocessor.

Thank you for any ideas how this problem can be solved!

--
Regards,
Anton Golubev
tel. +7 812 1185005 *7169
icq 70145498
Received on Sun Jan 09 2005 - 14:41:18 MST

This archive was generated by hypermail pre-2.1.9 : Mon Mar 07 2005 - 12:59:35 MST