At 10:01 AM -0700 3/8/10, Keith Christian wrote:
Hello fellow qpopper list dwellers,
I'm seeing a slowly increasing number of pop lock busy errors on our
mailserver. This mailserver load has been increasing over time but is
now capped. Running Qpopper 4.0.8.
Is there any interpretation of the reason for old lock files not being
removed? We see below 10 lock files more than 11 minutes old ("set
timeout = 600" in qpopper.cfg.)
Wondering why not all of the lock files are deleted, when the vast
majority are properly deleted?
Hi Keith,
My guess is that something is unexpectedly killing the Qpopper
processes before they can release the locks. I'd be interested in
finding out what's going on. How often does this happen? Is it
feasible to run Qpopper with debug tracing to capture a lock not
being released?
Mon Mar 8 16:31:20 GMT 2010
+ find /var/spool/mailtemp/ -maxdepth 1 -type f -name '.*.pop' '!'
-newer /tmp/lock_timer_watch -exec ls -l '{}' ';'
-rw-rw---- 1 wxyz8653 mail 0 Mar 8 13:40 /var/spool/mailtemp/.wxyz8653.pop
-rw-rw---- 1 wxyza7833 mail 0 Mar 4 15:53
/var/spool/mailtemp/.wxyza7833.pop
-rw-rw---- 1 wxyz15771 mail 0 Mar 4 13:03
/var/spool/mailtemp/.wxyz15771.pop
-rw-rw---- 1 wxyz19850 mail 0 Mar 8 15:46
/var/spool/mailtemp/.wxyz19850.pop
-rw-rw---- 1 wxyz27862 mail 0 Mar 8 14:04
/var/spool/mailtemp/.wxyz27862.pop
-rw-rw---- 1 wxyz11913 mail 0 Mar 5 13:39
/var/spool/mailtemp/.wxyz11913.pop
-rw-rw---- 1 wxyz21606 mail 0 Mar 5 16:53
/var/spool/mailtemp/.wxyz21606.pop
-rw-rw---- 1 wxyza4996 mail 0 Mar 5 19:21
/var/spool/mailtemp/.wxyza4996.pop
-rw-rw---- 1 wxyz27508 mail 0 Mar 8 14:05
/var/spool/mailtemp/.wxyz27508.pop
-rw-rw---- 1 wxyza20122 mail 0 Mar 5 17:04
/var/spool/mailtemp/.wxyza20122.pop
+ touch /tmp/lock_timer_watch
+ sleep 660
grep "IN\-USE" /var/log/maillog | tail
Mar 8 16:42:37 mailserver-a123 popper[30501]: wxyz28518 at
www.xxx.yyy.zzz (www.xxx.yyy.zzz): -ERR [IN-USE]
/var/spool/mailtemp/.wxyz28518.pop lock busy! Is another session
active? (11)
Mar 8 16:43:09 mailserver-a123 popper[30602]: wxyza20439 at
www.xxx.yyy.zzz (www.xxx.yyy.zzz): -ERR [IN-USE]
/var/spool/mailtemp/.wxyza20439.pop lock busy! Is another session
active? (11)
Mar 8 16:44:40 mailserver-a123 popper[31064]: wxyz28518 at
www.xxx.yyy.zzz (www.xxx.yyy.zzz): -ERR [IN-USE]
/var/spool/mailtemp/.wxyz28518.pop lock busy! Is another session
active? (11)
Mar 8 16:44:51 mailserver-a123 popper[31126]: wxyza3777 at
www.xxx.yyy.zzz (www.xxx.yyy.zzz): -ERR [IN-USE]
/var/spool/mailtemp/.wxyza3777.pop lock busy! Is another session
active? (11)
Mar 8 16:45:00 mailserver-a123 popper[31168]: wxyza30999 at
www.xxx.yyy.zzz (www.xxx.yyy.zzz): -ERR [IN-USE]
/var/spool/mailtemp/.wxyza30999.pop lock busy! Is another session
active? (11)
Mar 8 16:45:51 mailserver-a123 popper[31471]: wxyz19586 at
www.xxx.yyy.zzz (www.xxx.yyy.zzz): -ERR [IN-USE]
/var/spool/mailtemp/.wxyz19586.pop lock busy! Is another session
active? (11)
Mar 8 16:47:20 mailserver-a123 popper[31854]: wxyza27661 at
www.xxx.yyy.zzz (www.xxx.yyy.zzz): -ERR [IN-USE]
/var/spool/mailtemp/.wxyza27661.pop lock busy! Is another session
active? (11)
Mar 8 16:47:48 mailserver-a123 popper[31992]: wxyz4458 at
www.xxx.yyy.zzz (www.xxx.yyy.zzz): -ERR [IN-USE]
/var/spool/mailtemp/.wxyz4458.pop lock busy! Is another session
active? (11)
Mar 8 16:47:52 mailserver-a123 popper[31994]: wxyza6021 at
www.xxx.yyy.zzz (www.xxx.yyy.zzz): -ERR [IN-USE]
/var/spool/mailtemp/.wxyza6021.pop lock busy! Is another session
active? (11)
Mar 8 16:49:06 mailserver-a123 popper[32350]: wxyz11814 at
www.xxx.yyy.zzz (www.xxx.yyy.zzz): -ERR [IN-USE]
/var/spool/mailtemp/.wxyz11814.pop lock busy! Is another session
active? (11)
Thanks,
======Keith
--
Randall Gellens
Opinions are personal; facts are suspect; I speak for myself only
-------------- Randomly selected tag: ---------------
Certe, Toto, sentio nos in Kansate non iam adesse. --Dorothea
