Gentoo Archives: gentoo-user

From: Michael Sullivan <michael@××××××××××××.com>
To: gentoo-user@l.g.o
Subject: Re: [gentoo-user] Ot - Problem with CUPS server
Date: Sun, 06 Apr 2008 08:32:51
Message-Id: 1207470765.11865.60.camel@camille.espersunited.com
In Reply to: Re: [gentoo-user] Ot - Problem with CUPS server by Tim
1 On Sat, 2008-04-05 at 01:03 -0500, Tim wrote:
2 > Michael Sullivan wrote:
3 > > On Thu, 2008-04-03 at 10:22 -0400, David wrote:
4 > >>> Most recent messages in /var/log/cups/error_log:
5 > >>>
6 > >>> I [03/Apr/2008:08:19:57 -0500] Listening to :::631 on fd 2...
7 > >>> I [03/Apr/2008:08:19:57 -0500] Listening to 0.0.0.0:631 on fd 3...
8 > >>> I [03/Apr/2008:08:19:57 -0500] Listening to /var/run/cups/cups.sock on
9 > >>> fd 4...
10 > >>> I [03/Apr/2008:08:22:20 -0500] Adding start banner page "none" to job
11 > >>> 31.
12 > >>> I [03/Apr/2008:08:22:20 -0500] Adding end banner page "none" to job 31.
13 > >>> I [03/Apr/2008:08:22:20 -0500] Job 31 queued on "Charlie" by "michael".
14 > >>>
15 > >>> There don't seem to be any actual errors in the error_log. Strange. Is
16 > >>> there anything here that can hint as to why nothing is happening?
17 > >>>
18 > >>>
19 > >> # Log general information in error_log - change "info" to "debug" for
20 > >> # troubleshooting...
21 > >> LogLevel info
22 > >>
23 > >
24 > > I changed LogLevel to debug, erased /var/log/error_log (just to make
25 > > sure the information I was looking at was current), and restarted cupsd.
26 > > I sent a job from 192.168.1.3 (I was wrong - catherine is 192.168.1.4)
27 > > and checked /var/log/cups/error_log:
28 > >
29 > > catherine cups # cat error_log
30 > > I [03/Apr/2008:09:58:03 -0500] Saving job cache file
31 > > "/var/cache/cups/job.cache"...
32 > > I [03/Apr/2008:09:58:04 -0500] Listening to :::631 (IPv6)
33 > > I [03/Apr/2008:09:58:04 -0500] Listening to 0.0.0.0:631 (IPv4)
34 > > I [03/Apr/2008:09:58:04 -0500] Listening to /var/run/cups/cups.sock
35 > > (Domain)
36 > > I [03/Apr/2008:09:58:04 -0500] Loaded configuration file
37 > > "/etc/cups/cupsd.conf"
38 > > I [03/Apr/2008:09:58:04 -0500] Using default TempDir
39 > > of /var/spool/cups/tmp...
40 > > I [03/Apr/2008:09:58:04 -0500] Cleaning out old temporary files in
41 > > "/var/spool/cups/tmp"...
42 > > I [03/Apr/2008:09:58:04 -0500] Configured for up to 100 clients.
43 > > I [03/Apr/2008:09:58:04 -0500] Allowing up to 100 client connections per
44 > > host.
45 > > I [03/Apr/2008:09:58:04 -0500] Using policy "default" as the default!
46 > > I [03/Apr/2008:09:58:04 -0500] Full reload is required.
47 > > I [03/Apr/2008:09:58:04 -0500] Loaded MIME database from '/etc/cups': 35
48 > > types, 39 filters...
49 > > D [03/Apr/2008:09:58:04 -0500] Loading printer Charlie...
50 > > I [03/Apr/2008:09:58:04 -0500] Loading job cache file
51 > > "/var/cache/cups/job.cache"...
52 > > D [03/Apr/2008:09:58:04 -0500] Loading job 1 from cache...
53 > > D [03/Apr/2008:09:58:04 -0500] Loading job 2 from cache...
54 > > D [03/Apr/2008:09:58:04 -0500] Loading job 3 from cache...
55 > > D [03/Apr/2008:09:58:04 -0500] Loading job 4 from cache...
56 > > D [03/Apr/2008:09:58:04 -0500] Loading job 5 from cache...
57 > > D [03/Apr/2008:09:58:04 -0500] Loading job 6 from cache...
58 > > D [03/Apr/2008:09:58:04 -0500] Loading job 7 from cache...
59 > > D [03/Apr/2008:09:58:04 -0500] Loading job 8 from cache...
60 > > D [03/Apr/2008:09:58:04 -0500] Loading job 9 from cache...
61 > > D [03/Apr/2008:09:58:04 -0500] Loading job 10 from cache...
62 > > D [03/Apr/2008:09:58:04 -0500] Loading job 11 from cache...
63 > > D [03/Apr/2008:09:58:04 -0500] Loading job 12 from cache...
64 > > D [03/Apr/2008:09:58:04 -0500] Loading job 13 from cache...
65 > > D [03/Apr/2008:09:58:04 -0500] Loading job 14 from cache...
66 > > D [03/Apr/2008:09:58:04 -0500] Loading job 15 from cache...
67 > > D [03/Apr/2008:09:58:04 -0500] Loading job 16 from cache...
68 > > D [03/Apr/2008:09:58:04 -0500] Loading job 17 from cache...
69 > > D [03/Apr/2008:09:58:04 -0500] Loading job 18 from cache...
70 > > D [03/Apr/2008:09:58:04 -0500] Loading job 19 from cache...
71 > > D [03/Apr/2008:09:58:04 -0500] Loading job 20 from cache...
72 > > D [03/Apr/2008:09:58:04 -0500] Loading job 21 from cache...
73 > > D [03/Apr/2008:09:58:04 -0500] Loading job 22 from cache...
74 > > D [03/Apr/2008:09:58:04 -0500] Loading job 23 from cache...
75 > > D [03/Apr/2008:09:58:04 -0500] Loading job 24 from cache...
76 > > D [03/Apr/2008:09:58:04 -0500] Loading job 25 from cache...
77 > > D [03/Apr/2008:09:58:04 -0500] Loading job 26 from cache...
78 > > D [03/Apr/2008:09:58:04 -0500] Loading job 27 from cache...
79 > > D [03/Apr/2008:09:58:04 -0500] Loading job 28 from cache...
80 > > D [03/Apr/2008:09:58:04 -0500] Loading job 29 from cache...
81 > > D [03/Apr/2008:09:58:04 -0500] Loading job 30 from cache...
82 > > D [03/Apr/2008:09:58:04 -0500] Loading attributes for job 30...
83 > > D [03/Apr/2008:09:58:04 -0500] Loading job 31 from cache...
84 > > D [03/Apr/2008:09:58:04 -0500] Loading attributes for job 31...
85 > > D [03/Apr/2008:09:58:04 -0500] Loading job 32 from cache...
86 > > D [03/Apr/2008:09:58:04 -0500] Loading attributes for job 32...
87 > > I [03/Apr/2008:09:58:04 -0500] Full reload complete.
88 > > I [03/Apr/2008:09:58:04 -0500] Listening to :::631 on fd 2...
89 > > I [03/Apr/2008:09:58:04 -0500] Listening to 0.0.0.0:631 on fd 3...
90 > > I [03/Apr/2008:09:58:04 -0500] Listening to /var/run/cups/cups.sock on
91 > > fd 4...
92 > > D [03/Apr/2008:09:58:07 -0500] cupsdAcceptClient: 8 from 192.168.1.3:631
93 > > (IPv4)
94 > > D [03/Apr/2008:09:58:07 -0500] cupsdReadClient: 8 POST / HTTP/1.1
95 > > D [03/Apr/2008:09:58:07 -0500] cupsdAuthorize: No authentication data
96 > > provided.
97 > > D [03/Apr/2008:09:58:07 -0500] CUPS-Get-Printers
98 > > D [03/Apr/2008:09:58:07 -0500] cupsdProcessIPPRequest: 8 status_code=0
99 > > (successful-ok)
100 > > D [03/Apr/2008:09:58:07 -0500] cupsdReadClient: 8 POST / HTTP/1.1
101 > > D [03/Apr/2008:09:58:07 -0500] cupsdAuthorize: No authentication data
102 > > provided.
103 > > D [03/Apr/2008:09:58:07 -0500] CUPS-Get-Classes
104 > > D [03/Apr/2008:09:58:07 -0500] cupsdProcessIPPRequest: 8 status_code=0
105 > > (successful-ok)
106 > > D [03/Apr/2008:09:58:07 -0500] cupsdReadClient: 8 POST / HTTP/1.1
107 > > D [03/Apr/2008:09:58:07 -0500] cupsdAuthorize: No authentication data
108 > > provided.
109 > > D [03/Apr/2008:09:58:07 -0500] CUPS-Get-Default
110 > > D [03/Apr/2008:09:58:07 -0500] cupsdProcessIPPRequest: 8 status_code=0
111 > > (successful-ok)
112 > > D [03/Apr/2008:09:58:07 -0500] cupsdCloseClient: 8
113 > > D [03/Apr/2008:09:58:07 -0500] cupsdAcceptClient: 8 from 192.168.1.3:631
114 > > (IPv4)
115 > > D [03/Apr/2008:09:58:07 -0500] cupsdReadClient: 8 POST / HTTP/1.1
116 > > D [03/Apr/2008:09:58:07 -0500] cupsdAuthorize: No authentication data
117 > > provided.
118 > > D [03/Apr/2008:09:58:07 -0500] CUPS-Get-Printers
119 > > D [03/Apr/2008:09:58:07 -0500] cupsdProcessIPPRequest: 8 status_code=0
120 > > (successful-ok)
121 > > D [03/Apr/2008:09:58:07 -0500] cupsdReadClient: 8 POST / HTTP/1.1
122 > > D [03/Apr/2008:09:58:07 -0500] cupsdAuthorize: No authentication data
123 > > provided.
124 > > D [03/Apr/2008:09:58:07 -0500] CUPS-Get-Classes
125 > > D [03/Apr/2008:09:58:07 -0500] cupsdProcessIPPRequest: 8 status_code=0
126 > > (successful-ok)
127 > > D [03/Apr/2008:09:58:07 -0500] cupsdReadClient: 8 POST / HTTP/1.1
128 > > D [03/Apr/2008:09:58:07 -0500] cupsdAuthorize: No authentication data
129 > > provided.
130 > > D [03/Apr/2008:09:58:07 -0500] CUPS-Get-Default
131 > > D [03/Apr/2008:09:58:07 -0500] cupsdProcessIPPRequest: 8 status_code=0
132 > > (successful-ok)
133 > > D [03/Apr/2008:09:58:07 -0500] cupsdCloseClient: 8
134 > > D [03/Apr/2008:09:58:07 -0500] cupsdAcceptClient: 8 from 192.168.1.3:631
135 > > (IPv4)
136 > > D [03/Apr/2008:09:58:07 -0500] cupsdReadClient: 8 POST / HTTP/1.1
137 > > D [03/Apr/2008:09:58:07 -0500] cupsdAuthorize: No authentication data
138 > > provided.
139 > > D [03/Apr/2008:09:58:07 -0500] CUPS-Get-Printers
140 > > D [03/Apr/2008:09:58:07 -0500] cupsdProcessIPPRequest: 8 status_code=0
141 > > (successful-ok)
142 > > D [03/Apr/2008:09:58:07 -0500] cupsdReadClient: 8 POST / HTTP/1.1
143 > > D [03/Apr/2008:09:58:07 -0500] cupsdAuthorize: No authentication data
144 > > provided.
145 > > D [03/Apr/2008:09:58:07 -0500] CUPS-Get-Classes
146 > > D [03/Apr/2008:09:58:07 -0500] cupsdProcessIPPRequest: 8 status_code=0
147 > > (successful-ok)
148 > > D [03/Apr/2008:09:58:07 -0500] cupsdReadClient: 8 POST / HTTP/1.1
149 > > D [03/Apr/2008:09:58:07 -0500] cupsdAuthorize: No authentication data
150 > > provided.
151 > > D [03/Apr/2008:09:58:07 -0500] CUPS-Get-Default
152 > > D [03/Apr/2008:09:58:07 -0500] cupsdProcessIPPRequest: 8 status_code=0
153 > > (successful-ok)
154 > > D [03/Apr/2008:09:58:07 -0500] cupsdCloseClient: 8
155 > > D [03/Apr/2008:09:58:09 -0500] cupsdAcceptClient: 8 from 192.168.1.3:631
156 > > (IPv4)
157 > > D [03/Apr/2008:09:58:09 -0500] cupsdReadClient: 8 POST / HTTP/1.1
158 > > D [03/Apr/2008:09:58:09 -0500] cupsdAuthorize: No authentication data
159 > > provided.
160 > > D [03/Apr/2008:09:58:09 -0500] CUPS-Get-Printers
161 > > D [03/Apr/2008:09:58:09 -0500] cupsdProcessIPPRequest: 8 status_code=0
162 > > (successful-ok)
163 > > D [03/Apr/2008:09:58:09 -0500] cupsdReadClient: 8 POST / HTTP/1.1
164 > > D [03/Apr/2008:09:58:09 -0500] cupsdAuthorize: No authentication data
165 > > provided.
166 > > D [03/Apr/2008:09:58:09 -0500] CUPS-Get-Classes
167 > > D [03/Apr/2008:09:58:09 -0500] cupsdProcessIPPRequest: 8 status_code=0
168 > > (successful-ok)
169 > > D [03/Apr/2008:09:58:09 -0500] cupsdReadClient: 8 POST / HTTP/1.1
170 > > D [03/Apr/2008:09:58:09 -0500] cupsdAuthorize: No authentication data
171 > > provided.
172 > > D [03/Apr/2008:09:58:09 -0500] CUPS-Get-Default
173 > > D [03/Apr/2008:09:58:09 -0500] cupsdProcessIPPRequest: 8 status_code=0
174 > > (successful-ok)
175 > > D [03/Apr/2008:09:58:09 -0500] cupsdCloseClient: 8
176 > > D [03/Apr/2008:09:58:13 -0500] cupsdAcceptClient: 8 from 192.168.1.3:631
177 > > (IPv4)
178 > > D [03/Apr/2008:09:58:13 -0500] cupsdReadClient: 8 POST / HTTP/1.1
179 > > D [03/Apr/2008:09:58:13 -0500] cupsdAuthorize: No authentication data
180 > > provided.
181 > > D [03/Apr/2008:09:58:13 -0500] CUPS-Get-Printers
182 > > D [03/Apr/2008:09:58:13 -0500] cupsdProcessIPPRequest: 8 status_code=0
183 > > (successful-ok)
184 > > D [03/Apr/2008:09:58:13 -0500] cupsdReadClient: 8 POST / HTTP/1.1
185 > > D [03/Apr/2008:09:58:13 -0500] cupsdAuthorize: No authentication data
186 > > provided.
187 > > D [03/Apr/2008:09:58:13 -0500] CUPS-Get-Classes
188 > > D [03/Apr/2008:09:58:13 -0500] cupsdProcessIPPRequest: 8 status_code=0
189 > > (successful-ok)
190 > > D [03/Apr/2008:09:58:13 -0500] cupsdReadClient: 8 POST / HTTP/1.1
191 > > D [03/Apr/2008:09:58:13 -0500] cupsdAuthorize: No authentication data
192 > > provided.
193 > > D [03/Apr/2008:09:58:13 -0500] CUPS-Get-Default
194 > > D [03/Apr/2008:09:58:13 -0500] cupsdProcessIPPRequest: 8 status_code=0
195 > > (successful-ok)
196 > > D [03/Apr/2008:09:58:13 -0500] cupsdCloseClient: 8
197 > > D [03/Apr/2008:09:58:13 -0500] cupsdAcceptClient: 8 from 192.168.1.3:631
198 > > (IPv4)
199 > > D [03/Apr/2008:09:58:13 -0500] cupsdReadClient: 8 POST /printers/Charlie
200 > > HTTP/1.1
201 > > D [03/Apr/2008:09:58:13 -0500] cupsdAuthorize: No authentication data
202 > > provided.
203 > > D [03/Apr/2008:09:58:13 -0500] Print-Job
204 > > ipp://localhost/printers/Charlie
205 > > D [03/Apr/2008:09:58:13 -0500] print_job: auto-typing file...
206 > > D [03/Apr/2008:09:58:13 -0500] print_job: request file type is
207 > > application/postscript.
208 > > D [03/Apr/2008:09:58:13 -0500] add_job: requesting-user-name="michael"
209 > > I [03/Apr/2008:09:58:13 -0500] Adding start banner page "none" to job
210 > > 33.
211 > > D [03/Apr/2008:09:58:13 -0500] Discarding unused job-created event...
212 > > I [03/Apr/2008:09:58:13 -0500] Adding end banner page "none" to job 33.
213 > > I [03/Apr/2008:09:58:13 -0500] Job 33 queued on "Charlie" by "michael".
214 > > D [03/Apr/2008:09:58:13 -0500] Job 33 hold_until = 0
215 > > D [03/Apr/2008:09:58:13 -0500] cupsdProcessIPPRequest: 8 status_code=0
216 > > (successful-ok)
217 > >
218 > > Once again, it seems that cups thinks that the document was printed
219 > > successfully. What am I missing here?
220 > >
221 > Can you print from the console on catherine using lp? If so, can you
222 > print from the console on another machine?
223 >
224 > Have you recently upgraded the server? In some cases, documents sent as
225 > type application/octet-stream silently fail to print (I had this trouble
226 > a while ago) if the mime-type isn't enabled in /etc/cups/mime.types and
227 > mime.convs. Those files get replaced with some cups builds, and by
228 > default octet-stream isn't enabled in the packaged files. Do a
229 >
230 > # grep 'application/octet-stream' /etc/cups/mime.*
231 >
232 > to check that any line containing that phrase isn't commented.
233 >
234 > -Tim
235
236 OK. I can print echoing to /dev/lp0 on catherine. I haven't tried
237 printing from other boxes because I'm not quite sure how to echo
238 something to catherine's /dev/lp0 remotely. I still can't print from
239 seamonkey on catherine and konquerer still reports that something is
240 wrong with the CUPS server. I did grep those files:
241
242 catherine ~ # grep 'application/octet-stream' /etc/cups/mime.*
243 /etc/cups/mime.convs:application/octet-stream application/vnd.cups-raw
244 0 -
245 /etc/cups/mime.types:application/octet-stream
246
247 Still nothing useful in the error log. When I tried to step through the
248 printer config in the CUPS web interface and selected my printer model,
249 it said that it couldn't copy the PPD file. Our printer is an Epson
250 Stylus C88. I ordered a test page printed about half an hour ago, and
251 when I stepped through the printer config it suddenly printed it. The
252 test page looked good, but seamonkey still crashes if I try to access
253 the Print dialogue (including Print Preview). What else can I do?
254
255 --
256 gentoo-user@l.g.o mailing list