<html xmlns:o="urn:schemas-microsoft-com:office:office" xmlns:w="urn:schemas-microsoft-com:office:word" xmlns:st1="urn:schemas-microsoft-com:office:smarttags" xmlns="http://www.w3.org/TR/REC-html40">

<head>
<meta http-equiv=Content-Type content="text/html; charset=us-ascii">
<meta name=Generator content="Microsoft Word 11 (filtered medium)">
<title>I’m having a problem with cups hanging when restarting after I
perform my weekly log rotation which runs through a cron</title>
<o:SmartTagType namespaceuri="urn:schemas-microsoft-com:office:smarttags"
 name="place"/>
<!--[if !mso]>
<style>
st1\:*{behavior:url(#default#ieooui) }
</style>
<![endif]-->
<style>
<!--
 /* Style Definitions */
 p.MsoNormal, li.MsoNormal, div.MsoNormal
        {margin:0in;
        margin-bottom:.0001pt;
        font-size:12.0pt;
        font-family:"Times New Roman";}
a:link, span.MsoHyperlink
        {color:blue;
        text-decoration:underline;}
a:visited, span.MsoHyperlinkFollowed
        {color:#606420;
        text-decoration:underline;}
span.EmailStyle17
        {mso-style-type:personal-compose;
        font-family:Arial;
        color:windowtext;}
@page Section1
        {size:8.5in 11.0in;
        margin:1.0in 1.25in 1.0in 1.25in;}
div.Section1
        {page:Section1;}
-->
</style>

</head>

<body lang=EN-US link=blue vlink="#606420">

<div class=Section1>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>I’m having a problem with cups hanging when restarting
after I perform my weekly log rotation which runs through the cron.daily
job.  It shuts down fine but when it’s time to start again, it hangs
when detecting a device…  All of my servers are running Red Hat
enterprise 3 with cups-1.1.17-13.3.6 but only one of them is having this
problem so I upgraded this particular server to cups-1.1.20-2 hoping it might
help but I am still having the same issue.  My other servers still run
1.1.17-13.3.6 and start fine after the log rotate… <o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'><o:p> </o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>When I come into work on Monday (the problem only arises on Monday
at 2AM), I can’t access <a href="http://localhost:631/">http://localhost:631</a>
and I have this result when I do “ps -aux | grep cups”:<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'><o:p> </o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>root     23577  0.0  0.0 
2128  884  ?       <st1:place w:st="on">S   
 Jul18</st1:place>   0:00 /bin/sh /tmp/logrotate.yAIOup
/var/log/cups/*_log<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>root     23578  0.0  0.1 
2144 1088 ?       <st1:place w:st="on">S   
 Jul18</st1:place>   0:00 /bin/sh /etc/init.d/cups condrestart<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>root     23592  0.0  0.0 
1520  492  ?       <st1:place w:st="on">S   
 Jul18</st1:place>   0:00 initlog -q -c cupsd<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>root     23593  0.0  0.0 
4224  992  ?       <st1:place w:st="on">S   
 Jul18</st1:place>   0:00 cupsd<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>root     23594  0.0  0.1 
5724 1896 ?       <st1:place w:st="on">S   
 Jul18</st1:place>   0:00 cupsd<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>root     23602  0.0  0.0 
3620  860  ?       <st1:place w:st="on">S   
 Jul18</st1:place>   0:00 /usr/lib/cups/backend/serial<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>root     29873  0.0  0.0 
1612  492  pts/0 S    15:27   0:00 grep cups<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'><o:p> </o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>When I kill “/usr/lib/cups/backend/serial”, cups
will continue loading perfectly.<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'><o:p> </o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>Below is the cups error log.  Notice that it stops
loading at line “LoadDevices: Backend did not respond within 30
seconds!”.   Notice also in the following log that I killed the
process specified above at 15:27:14)<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'><o:p> </o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>I [18/Jul/2004:04:02:03 -0400] Listening to 0:631<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] AddLocation: added location
'/admin'<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] DenyIP: /admin deny IP/MASK<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] AllowIP: /admin allow IP/MASK<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] AddLocation: added location
'/'<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] DenyIP: / deny IP/MASK<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] AllowIP: / allow IP/MASK<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>I [18/Jul/2004:04:02:03 -0400] Loaded configuration file
"/etc/cups/cupsd.conf"<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>I [18/Jul/2004:04:02:03 -0400] Configured for up to 100
clients.<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>I [18/Jul/2004:04:02:03 -0400] Allowing up to 100 client
connections per host.<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>I [18/Jul/2004:04:02:03 -0400] Full reload is required.<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] LoadAllPrinters: Loading
printer PRINTERNAME...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] LoadAllPrinters: Loading
printer PRINTERNAME...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>#…more printers loaded…<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] LoadDevices: Added device
"http"...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] LoadDevices: Added device
"ipp"...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] LoadDevices: Added device
"lpd"...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] LoadDevices: Added device
"smb"...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [18/Jul/2004:04:02:03 -0400] LoadDevices: Added device
"scsi"...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>W [18/Jul/2004:04:02:33 -0400] LoadDevices: Backend did not
respond within 30 seconds!<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [19/Jul/2004:15:27:14 -0400] LoadDevices: Added device
"socket"...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [19/Jul/2004:15:27:14 -0400] LoadDevices: Added device
"usb:/dev/usb/lp0"...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [19/Jul/2004:15:27:14 -0400] LoadDevices: Added device
"usb:/dev/usb/lp1"...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [19/Jul/2004:15:27:14 -0400] LoadDevices: Added device
"usb:/dev/usb/lp2"...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>#…more usb devices added…<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>I [19/Jul/2004:15:27:14 -0400] LoadPPDs: Read
"/etc/cups/ppds.dat", 2000 PPDs...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>I [19/Jul/2004:15:27:14 -0400] LoadPPDs: No new or changed
PPDs...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [19/Jul/2004:15:27:14 -0400] LoadAllJobs: Scanning
/var/spool/cups...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [19/Jul/2004:15:27:14 -0400] LoadAllJobs: Loading
attributes for job 1...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [19/Jul/2004:15:27:14 -0400] LoadAllJobs: Loading
attributes for job 2...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>#…loading other jobs…<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>I [19/Jul/2004:15:27:14 -0400] Full reload complete.<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [19/Jul/2004:15:27:14 -0400] StartListening:
NumListeners=1<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [19/Jul/2004:15:27:14 -0400] StartListening:
address=00000000 port=631<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>D [19/Jul/2004:15:27:14 -0400] ResumeListening: setting
input bits...<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>#...and now it starts printing…<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'><o:p> </o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>I googled “LoadDevices: Backend did not respond within
30 seconds!”  but that didn’t help me much…<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'><o:p> </o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>I don’t know what is causing this since the cupsd.conf
files are exactly the same on all servers except for the DENY/ALLOW IPs in
“Location /” which vary from one server to the next but I
don’t think that would have any impact on cups restarting...  Any
ideas as to what is causing this or how to fix it would be greatly
appreciated.  It’s not a big deal but I’ve been having this
problem for weeks now and I can’t figure out why so I thought I’d
put a post to see if I could get more help…<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'> <o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>Thanks,<o:p></o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'><o:p> </o:p></span></font></p>

<p class=MsoNormal><font size=2 face=Arial><span style='font-size:10.0pt;
font-family:Arial'>F-J Poitras<o:p></o:p></span></font></p>

</div>

</body>

</html>