[Pkg-cups-devel] Bug#762338: Generated PDF has tiny font size
martin f krafft
madduck at debian.org
Sun Sep 21 10:23:59 UTC 2014
Package: cups-pdf
Version: 2.6.1-12
Severity: normal
On a new Sid installation (Ghostscript 9.06~dfsg-1, but same problem
with 9.15~rc1~dfsg-1 from experimental), the command
echo bla | lp -d PDF
produces the attached PDF, which contains text with the tiniest
possible font size.
The cupsd debug log of the job is attached.
-- System Information:
Debian Release: jessie/sid
APT prefers unstable
APT policy: (500, 'unstable'), (1, 'experimental')
Architecture: amd64 (x86_64)
Foreign Architectures: i386
Kernel: Linux 3.16-1-amd64 (SMP w/4 CPU cores)
Locale: LANG=en_NZ, LC_CTYPE=en_NZ.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Versions of packages cups-pdf depends on:
ii printer-driver-cups-pdf 2.6.1-12
cups-pdf recommends no packages.
cups-pdf suggests no packages.
-- no debconf information
--
.''`. martin f. krafft <madduck at d.o> @martinkrafft
: :' : proud Debian developer
`. `'` http://people.debian.org/~madduck
`- Debian - when you have better things to do than fixing systems
-------------- next part --------------
A non-text attachment was scrubbed...
Name: _stdin_.pdf
Type: application/pdf
Size: 4039 bytes
Desc: not available
URL: <http://lists.alioth.debian.org/pipermail/pkg-cups-devel/attachments/20140921/0b8094e3/attachment-0001.pdf>
-------------- next part --------------
I [21/Sep/2014:12:17:20 +0200] Listening to [v1.::1]:631 (IPv6)
I [21/Sep/2014:12:17:20 +0200] Listening to 127.0.0.1:631 (IPv4)
I [21/Sep/2014:12:17:20 +0200] Listening to /var/run/cups/cups.sock (Domain)
I [21/Sep/2014:12:17:20 +0200] Remote access is disabled.
D [21/Sep/2014:12:17:20 +0200] Added auto ServerAlias fishbowl
I [21/Sep/2014:12:17:20 +0200] Loaded configuration file "/etc/cups/cupsd.conf"
I [21/Sep/2014:12:17:20 +0200] Using default TempDir of /var/spool/cups/tmp...
I [21/Sep/2014:12:17:20 +0200] Configured for up to 100 clients.
I [21/Sep/2014:12:17:20 +0200] Allowing up to 100 client connections per host.
I [21/Sep/2014:12:17:20 +0200] Using policy "default" as the default.
I [21/Sep/2014:12:17:20 +0200] Full reload is required.
I [21/Sep/2014:12:17:20 +0200] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 39 types, 53 filters...
D [21/Sep/2014:12:17:20 +0200] Loading printer hplj3052...
D [21/Sep/2014:12:17:20 +0200] cupsdMarkDirty(P----)
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Not busy"
D [21/Sep/2014:12:17:20 +0200] load_ppd: Loading /etc/cups/ppd/hplj3052.ppd...
D [21/Sep/2014:12:17:20 +0200] cupsdRegisterPrinter(p=0x7fafe54dbf50(hplj3052))
D [21/Sep/2014:12:17:20 +0200] Loading printer PDF...
D [21/Sep/2014:12:17:20 +0200] load_ppd: Loading /var/cache/cups/PDF.data...
D [21/Sep/2014:12:17:20 +0200] cupsdRegisterPrinter(p=0x7fafe54e0060(PDF))
I [21/Sep/2014:12:17:20 +0200] Loading job cache file "/var/cache/cups/job.cache"...
D [21/Sep/2014:12:17:20 +0200] [Job 1] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 5] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 7] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 8] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 12] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 14] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 15] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 16] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 17] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 18] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 19] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 20] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 21] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 22] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 23] Loading from cache...
D [21/Sep/2014:12:17:20 +0200] [Job 24] Loading from cache...
I [21/Sep/2014:12:17:20 +0200] Full reload complete.
D [21/Sep/2014:12:17:20 +0200] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [21/Sep/2014:12:17:20 +0200] Cleaning out old files in "/var/spool/cups/tmp".
D [21/Sep/2014:12:17:20 +0200] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
I [21/Sep/2014:12:17:20 +0200] Cleaning out old files in "/var/cache/cups".
D [21/Sep/2014:12:17:20 +0200] systemd_checkin: Matched existing listener /var/run/cups/cups.sock with fd 3...
D [21/Sep/2014:12:17:20 +0200] systemd_checkin: Matched existing listener 127.0.0.1 with fd 4...
D [21/Sep/2014:12:17:20 +0200] systemd_checkin: Matched existing listener [v1.::1] with fd 5...
D [21/Sep/2014:12:17:20 +0200] systemd_checkin: Activate exit-on-idle mode, timeout: 30 seconds.
D [21/Sep/2014:12:17:20 +0200] Calling FindDeviceById(cups-hplj3052)
D [21/Sep/2014:12:17:20 +0200] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [21/Sep/2014:12:17:20 +0200] Calling FindDeviceById(cups-PDF)
D [21/Sep/2014:12:17:20 +0200] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [21/Sep/2014:12:17:20 +0200] Using profile ID "PDF-Gray..".
D [21/Sep/2014:12:17:20 +0200] Calling CreateProfile(PDF-Gray..,temp)
W [21/Sep/2014:12:17:20 +0200] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [21/Sep/2014:12:17:20 +0200] Using profile ID "PDF-RGB..".
D [21/Sep/2014:12:17:20 +0200] Calling CreateProfile(PDF-RGB..,temp)
W [21/Sep/2014:12:17:20 +0200] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [21/Sep/2014:12:17:20 +0200] Registering ICC color profiles for "PDF".
D [21/Sep/2014:12:17:20 +0200] Calling CreateDevice(cups-PDF,temp)
W [21/Sep/2014:12:17:20 +0200] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [21/Sep/2014:12:17:20 +0200] Listening to [v1.::1]:631 on fd 5...
I [21/Sep/2014:12:17:20 +0200] Listening to 127.0.0.1:631 on fd 4...
I [21/Sep/2014:12:17:20 +0200] Listening to /var/run/cups/cups.sock:631 on fd 3...
I [21/Sep/2014:12:17:20 +0200] Resuming new connection processing...
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:20 +0200] Discarding unused server-started event...
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 14] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:20 +0200] [Client 14] Waiting for request.
D [21/Sep/2014:12:17:20 +0200] Report: clients=1
D [21/Sep/2014:12:17:20 +0200] Report: jobs=16
D [21/Sep/2014:12:17:20 +0200] Report: jobs-active=0
D [21/Sep/2014:12:17:20 +0200] Report: printers=2
D [21/Sep/2014:12:17:20 +0200] Report: stringpool-string-count=1267
D [21/Sep/2014:12:17:20 +0200] Report: stringpool-alloc-bytes=11304
D [21/Sep/2014:12:17:20 +0200] Report: stringpool-total-bytes=24160
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 14] POST / HTTP/1.1
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:20 +0200] [Client 14] No authentication data provided.
D [21/Sep/2014:12:17:20 +0200] [Client 14] 2.0 CUPS-Get-Printers 1
D [21/Sep/2014:12:17:20 +0200] CUPS-Get-Printers
D [21/Sep/2014:12:17:20 +0200] [Client 14] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [21/Sep/2014:12:17:20 +0200] [Client 14] Content-Length: 1811
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1811, response=0x7fafe5521560(IPP_IDLE), pipe_pid=0, file=-1
D [21/Sep/2014:12:17:20 +0200] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [21/Sep/2014:12:17:20 +0200] [Client 14] bytes=0, http_state=0, data_remaining=0
D [21/Sep/2014:12:17:20 +0200] [Client 14] Waiting for request.
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 14] POST / HTTP/1.1
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:20 +0200] [Client 14] No authentication data provided.
D [21/Sep/2014:12:17:20 +0200] [Client 14] 2.0 CUPS-Get-Default 2
D [21/Sep/2014:12:17:20 +0200] CUPS-Get-Default
D [21/Sep/2014:12:17:20 +0200] [Client 14] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [21/Sep/2014:12:17:20 +0200] [Client 14] Content-Length: 12563
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=12563, response=0x7fafe5521b00(IPP_IDLE), pipe_pid=0, file=-1
D [21/Sep/2014:12:17:20 +0200] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [21/Sep/2014:12:17:20 +0200] [Client 14] bytes=0, http_state=0, data_remaining=0
D [21/Sep/2014:12:17:20 +0200] [Client 14] Waiting for request.
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 14] POST / HTTP/1.1
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:20 +0200] [Client 14] No authentication data provided.
D [21/Sep/2014:12:17:20 +0200] [Client 14] 2.0 CUPS-Get-Printers 3
D [21/Sep/2014:12:17:20 +0200] CUPS-Get-Printers
D [21/Sep/2014:12:17:20 +0200] [Client 14] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [21/Sep/2014:12:17:20 +0200] [Client 14] Content-Length: 1811
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1811, response=0x7fafe5521b50(IPP_IDLE), pipe_pid=0, file=-1
D [21/Sep/2014:12:17:20 +0200] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [21/Sep/2014:12:17:20 +0200] [Client 14] bytes=0, http_state=0, data_remaining=0
D [21/Sep/2014:12:17:20 +0200] [Client 14] Waiting for request.
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 14] POST / HTTP/1.1
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:20 +0200] [Client 14] No authentication data provided.
D [21/Sep/2014:12:17:20 +0200] [Client 14] 2.0 CUPS-Get-Default 4
D [21/Sep/2014:12:17:20 +0200] CUPS-Get-Default
D [21/Sep/2014:12:17:20 +0200] [Client 14] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [21/Sep/2014:12:17:20 +0200] [Client 14] Content-Length: 12563
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=12563, response=0x7fafe5521b00(IPP_IDLE), pipe_pid=0, file=-1
D [21/Sep/2014:12:17:20 +0200] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [21/Sep/2014:12:17:20 +0200] [Client 14] bytes=0, http_state=0, data_remaining=0
D [21/Sep/2014:12:17:20 +0200] [Client 14] Waiting for request.
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 15] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:20 +0200] [Client 15] Waiting for request.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 16] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:20 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:20 +0200] [Client 15] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:20 +0200] [Client 15] Closing connection.
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 16] POST / HTTP/1.1
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:20 +0200] [Client 16] No authentication data provided.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 16] 2.0 CUPS-Get-Printers 1
D [21/Sep/2014:12:17:20 +0200] CUPS-Get-Printers
D [21/Sep/2014:12:17:20 +0200] [Client 16] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [21/Sep/2014:12:17:20 +0200] [Client 16] Content-Length: 1653
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:20 +0200] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1653, response=0x7fafe5521510(IPP_IDLE), pipe_pid=0, file=-1
D [21/Sep/2014:12:17:20 +0200] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [21/Sep/2014:12:17:20 +0200] [Client 16] bytes=0, http_state=0, data_remaining=0
D [21/Sep/2014:12:17:20 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:20 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:20 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:21 +0200] [Client 15] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:21 +0200] [Client 16] Closing connection.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] GET /printers/PDF.ppd HTTP/1.1
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] [Client 15] No authentication data provided.
D [21/Sep/2014:12:17:21 +0200] [Client 15] Sending file.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=20940, response=(nil)(), pipe_pid=0, file=16
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=18892, response=(nil)(), pipe_pid=0, file=16
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=16844, response=(nil)(), pipe_pid=0, file=16
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=14796, response=(nil)(), pipe_pid=0, file=16
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=12748, response=(nil)(), pipe_pid=0, file=16
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=10700, response=(nil)(), pipe_pid=0, file=16
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=8652, response=(nil)(), pipe_pid=0, file=16
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6604, response=(nil)(), pipe_pid=0, file=16
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=4556, response=(nil)(), pipe_pid=0, file=16
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=2508, response=(nil)(), pipe_pid=0, file=16
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=460, response=(nil)(), pipe_pid=0, file=16
D [21/Sep/2014:12:17:21 +0200] [Client 15] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:21 +0200] [Client 15] Closing connection.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:21 +0200] [Client 15] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:21 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] [Client 15] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:21 +0200] [Client 15] Closing connection.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] POST / HTTP/1.1
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] [Client 16] No authentication data provided.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] 2.0 CUPS-Get-Printers 1
D [21/Sep/2014:12:17:21 +0200] CUPS-Get-Printers
D [21/Sep/2014:12:17:21 +0200] [Client 16] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [21/Sep/2014:12:17:21 +0200] [Client 16] Content-Length: 1653
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1653, response=0x7fafe5521510(IPP_IDLE), pipe_pid=0, file=-1
D [21/Sep/2014:12:17:21 +0200] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [21/Sep/2014:12:17:21 +0200] [Client 16] bytes=0, http_state=0, data_remaining=0
D [21/Sep/2014:12:17:21 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:21 +0200] [Client 16] Closing connection.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:21 +0200] [Client 15] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:21 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] [Client 15] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:21 +0200] [Client 15] Closing connection.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] POST / HTTP/1.1
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] [Client 16] No authentication data provided.
D [21/Sep/2014:12:17:21 +0200] [Client 16] 2.0 CUPS-Get-Printers 1
D [21/Sep/2014:12:17:21 +0200] CUPS-Get-Printers
D [21/Sep/2014:12:17:21 +0200] [Client 16] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [21/Sep/2014:12:17:21 +0200] [Client 16] Content-Length: 1653
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1653, response=0x7fafe5521510(IPP_IDLE), pipe_pid=0, file=-1
D [21/Sep/2014:12:17:21 +0200] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [21/Sep/2014:12:17:21 +0200] [Client 16] bytes=0, http_state=0, data_remaining=0
D [21/Sep/2014:12:17:21 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:21 +0200] [Client 16] Closing connection.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:21 +0200] [Client 15] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:21 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] [Client 15] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:21 +0200] [Client 15] Closing connection.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] POST / HTTP/1.1
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] [Client 16] No authentication data provided.
D [21/Sep/2014:12:17:21 +0200] [Client 16] 2.0 CUPS-Get-Printers 1
D [21/Sep/2014:12:17:21 +0200] CUPS-Get-Printers
D [21/Sep/2014:12:17:21 +0200] [Client 16] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [21/Sep/2014:12:17:21 +0200] [Client 16] Content-Length: 1653
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1653, response=0x7fafe5521510(IPP_IDLE), pipe_pid=0, file=-1
D [21/Sep/2014:12:17:21 +0200] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [21/Sep/2014:12:17:21 +0200] [Client 16] bytes=0, http_state=0, data_remaining=0
D [21/Sep/2014:12:17:21 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:21 +0200] [Client 16] Closing connection.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 15] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:21 +0200] [Client 15] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:21 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] [Client 15] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:21 +0200] [Client 15] Closing connection.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] POST / HTTP/1.1
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] [Client 16] No authentication data provided.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] 2.0 CUPS-Get-Printers 1
D [21/Sep/2014:12:17:21 +0200] CUPS-Get-Printers
D [21/Sep/2014:12:17:21 +0200] [Client 16] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [21/Sep/2014:12:17:21 +0200] [Client 16] Content-Length: 1653
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1653, response=0x7fafe5521510(IPP_IDLE), pipe_pid=0, file=-1
D [21/Sep/2014:12:17:21 +0200] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [21/Sep/2014:12:17:21 +0200] [Client 16] bytes=0, http_state=0, data_remaining=0
D [21/Sep/2014:12:17:21 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:21 +0200] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:21 +0200] [Client 16] Closing connection.
D [21/Sep/2014:12:17:21 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:21 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] [Client 15] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:22 +0200] [Client 15] Waiting for request.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] [Client 16] Accepted from localhost (Domain)
D [21/Sep/2014:12:17:22 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] [Client 16] POST /printers/PDF HTTP/1.1
D [21/Sep/2014:12:17:22 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [21/Sep/2014:12:17:22 +0200] [Client 16] No authentication data provided.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] [Client 16] 2.1 Print-Job 1
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] Print-Job ipp://localhost:631/printers/PDF
D [21/Sep/2014:12:17:22 +0200] [Job ???] Auto-typing file...
I [21/Sep/2014:12:17:22 +0200] [Job ???] Request file type is application/pdf.
D [21/Sep/2014:12:17:22 +0200] cupsdMarkDirty(---J-)
D [21/Sep/2014:12:17:22 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:22 +0200] add_job: requesting-user-name="madduck"
I [21/Sep/2014:12:17:22 +0200] [Job 25] Adding start banner page "none".
D [21/Sep/2014:12:17:22 +0200] Discarding unused job-created event...
D [21/Sep/2014:12:17:22 +0200] cupsdMarkDirty(---J-)
D [21/Sep/2014:12:17:22 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [21/Sep/2014:12:17:22 +0200] [Job 25] Adding end banner page "none".
I [21/Sep/2014:12:17:22 +0200] [Job 25] File of type application/pdf queued by "madduck".
D [21/Sep/2014:12:17:22 +0200] [Job 25] hold_until=0
I [21/Sep/2014:12:17:22 +0200] [Job 25] Queued on "PDF" by "madduck".
D [21/Sep/2014:12:17:22 +0200] [Job 25] time-at-processing=1411294642
D [21/Sep/2014:12:17:22 +0200] cupsdMarkDirty(---J-)
D [21/Sep/2014:12:17:22 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:22 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:22 +0200] Discarding unused printer-state-changed event...
D [21/Sep/2014:12:17:22 +0200] [Job 25] 3 filters for job:
D [21/Sep/2014:12:17:22 +0200] [Job 25] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [21/Sep/2014:12:17:22 +0200] [Job 25] pdftops (application/vnd.cups-pdf to application/vnd.cups-postscript, cost 100)
D [21/Sep/2014:12:17:22 +0200] [Job 25] - (application/vnd.cups-postscript to printer/PDF, cost 0)
D [21/Sep/2014:12:17:22 +0200] [Job 25] job-sheets=none,none
D [21/Sep/2014:12:17:22 +0200] [Job 25] argv[0]="PDF"
D [21/Sep/2014:12:17:22 +0200] [Job 25] argv[1]="25"
D [21/Sep/2014:12:17:22 +0200] [Job 25] argv[2]="madduck"
D [21/Sep/2014:12:17:22 +0200] [Job 25] argv[3]="django-gitcms/load.py at master ? luispedro/django-gitcms"
D [21/Sep/2014:12:17:22 +0200] [Job 25] argv[4]="1"
D [21/Sep/2014:12:17:22 +0200] [Job 25] argv[5]="PageSize=A4 Resolution=300dpi number-up=1 job-uuid=urn:uuid:1441d73c-f580-3aed-6b53-0bad28664a4d job-originating-host-name=localhost time-at-creation=1411294642 time-at-processing=1411294642"
D [21/Sep/2014:12:17:22 +0200] [Job 25] argv[6]="/var/spool/cups/d00025-001"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[8]="HOME=/var/spool/cups/tmp"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[10]="SERVER_ADMIN=root at fishbowl"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[11]="SOFTWARE=CUPS/1.7.5"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[13]="USER=root"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[14]="CUPS_MAX_MESSAGE=2047"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[17]="IPP_PORT=631"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[18]="CHARSET=utf-8"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[19]="LANG=en_NZ.UTF-8"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[20]="PPD=/etc/cups/ppd/PDF.ppd"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[21]="RIP_MAX_CACHE=128m"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[22]="CONTENT_TYPE=application/pdf"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[23]="DEVICE_URI=cups-pdf:/"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[24]="PRINTER_INFO=PDF"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[25]="PRINTER_LOCATION="
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[26]="PRINTER=PDF"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[27]="PRINTER_STATE_REASONS=none"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[28]="CUPS_FILETYPE=document"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[29]="FINAL_CONTENT_TYPE=printer/PDF"
D [21/Sep/2014:12:17:22 +0200] [Job 25] envp[30]="AUTH_I****"
I [21/Sep/2014:12:17:22 +0200] [Job 25] Started filter /usr/lib/cups/filter/pdftopdf (PID 18562)
I [21/Sep/2014:12:17:22 +0200] [Job 25] Started filter /usr/lib/cups/filter/pdftops (PID 18563)
I [21/Sep/2014:12:17:22 +0200] [Job 25] Started backend /usr/lib/cups/backend/cups-pdf (PID 18564)
D [21/Sep/2014:12:17:22 +0200] Discarding unused job-state-changed event...
D [21/Sep/2014:12:17:22 +0200] [Client 16] Returning IPP successful-ok for Print-Job (ipp://localhost:631/printers/PDF) from localhost
D [21/Sep/2014:12:17:22 +0200] [Client 16] Content-Length: 174
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=174, response=0x7fafe5521780(IPP_IDLE), pipe_pid=0, file=-1
D [21/Sep/2014:12:17:22 +0200] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [21/Sep/2014:12:17:22 +0200] [Client 16] bytes=0, http_state=0, data_remaining=0
D [21/Sep/2014:12:17:22 +0200] [Client 16] Waiting for request.
D [21/Sep/2014:12:17:22 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files"
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] [Job 25] pdftops - copying to temp print file "/var/spool/cups/tmp/04883542bb8f8"
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:22 +0200] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [21/Sep/2014:12:17:22 +0200] [Client 16] Closing connection.
D [21/Sep/2014:12:17:22 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [21/Sep/2014:12:17:22 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:23 +0200] [Job 25] PID 18562 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [21/Sep/2014:12:17:23 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:23 +0200] [Job 25] Printer make and model: Generic CUPS v1.1
D [21/Sep/2014:12:17:23 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:23 +0200] [Job 25] Running command line for pstops: pstops 25 madduck 'django-gitcms/load.py at master ? luispedro/django-gitcms' 1 'PageSize=A4 Resolution=300dpi job-uuid=urn:uuid:1441d73c-f580-3aed-6b53-0bad28664a4d job-originating-host-name=localhost time-at-creation=1411294642 time-at-processing=1411294642'
D [21/Sep/2014:12:17:23 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:23 +0200] [Job 25] Using image rendering resolution 300 dpi
D [21/Sep/2014:12:17:23 +0200] [Job 25] Running command line for gs: gs -q -dNOPAUSE -dBATCH -dSAFER -sDEVICE=ps2write -sOUTPUTFILE=%stdout -dLanguageLevel=2 -r300 -dCompressFonts=false -dNoT3CCITT -dNOINTERPOLATE -c 'save pop' -f /var/spool/cups/tmp/04883542bb8f8
D [21/Sep/2014:12:17:23 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:23 +0200] [Job 25] Started filter gs (PID 18565)
D [21/Sep/2014:12:17:23 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:23 +0200] [Job 25] Started filter pstops (PID 18566)
D [21/Sep/2014:12:17:23 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:24 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:24 +0200] [Job 25] Page = 595x842; 0,0 to 595,842
D [21/Sep/2014:12:17:24 +0200] [Job 25] slow_collate=0, slow_duplex=0, slow_order=0
D [21/Sep/2014:12:17:24 +0200] [Job 25] Before copy_comments - %!PS-Adobe-3.0
D [21/Sep/2014:12:17:24 +0200] [Job 25] %!PS-Adobe-3.0
D [21/Sep/2014:12:17:24 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:24 +0200] [Job 25] %%BoundingBox: 0 0 596 842
D [21/Sep/2014:12:17:24 +0200] [Job 25] %%HiResBoundingBox: 0 0 596.00 842.00
D [21/Sep/2014:12:17:24 +0200] [Job 25] %%Creator: GPL Ghostscript RELEASE CANDIDATE 1 915 (ps2write)
D [21/Sep/2014:12:17:24 +0200] [Job 25] %%LanguageLevel: 2
D [21/Sep/2014:12:17:24 +0200] [Job 25] %%CreationDate: D:20140921121723+02'00'
D [21/Sep/2014:12:17:24 +0200] [Job 25] %%Pages: 1
D [21/Sep/2014:12:17:24 +0200] [Job 25] %%EndComments
D [21/Sep/2014:12:17:24 +0200] [Job 25] Before copy_prolog - %%BeginProlog
D [21/Sep/2014:12:17:24 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:24 +0200] [Job 25] Before copy_setup - %%Page: 1 1
D [21/Sep/2014:12:17:24 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:24 +0200] [Job 25] Before page loop - %%Page: 1 1
D [21/Sep/2014:12:17:24 +0200] [Job 25] Copying page 1...
D [21/Sep/2014:12:17:24 +0200] [Job 25] PAGE: 1 1
D [21/Sep/2014:12:17:24 +0200] Discarding unused job-progress event...
D [21/Sep/2014:12:17:24 +0200] [Job 25] pagew = 595.0, pagel = 842.0
D [21/Sep/2014:12:17:24 +0200] [Job 25] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [21/Sep/2014:12:17:24 +0200] [Job 25] PageLeft = 0.0, PageRight = 595.0
D [21/Sep/2014:12:17:24 +0200] [Job 25] PageTop = 842.0, PageBottom = 0.0
D [21/Sep/2014:12:17:24 +0200] [Job 25] PageWidth = 595.0, PageLength = 842.0
D [21/Sep/2014:12:17:24 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:24 +0200] [Job 25] Wrote 1 pages...
D [21/Sep/2014:12:17:24 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:24 +0200] [Job 25] PID 18566 (pstops) exited with no errors.
D [21/Sep/2014:12:17:24 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:24 +0200] [Job 25] PID 18565 (gs) exited with no errors.
D [21/Sep/2014:12:17:24 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:24 +0200] [Job 25] PID 18563 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [21/Sep/2014:12:17:24 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:24 +0200] [Job 25] PID 18564 (/usr/lib/cups/backend/cups-pdf) exited with no errors.
D [21/Sep/2014:12:17:24 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:24 +0200] [Job 25] time-at-completed=1411294644
D [21/Sep/2014:12:17:24 +0200] Discarding unused job-completed event...
I [21/Sep/2014:12:17:24 +0200] [Job 25] Job completed.
D [21/Sep/2014:12:17:24 +0200] cupsdMarkDirty(---J-)
D [21/Sep/2014:12:17:24 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [21/Sep/2014:12:17:24 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [21/Sep/2014:12:17:24 +0200] Discarding unused printer-state-changed event...
D [21/Sep/2014:12:17:24 +0200] cupsdMarkDirty(---J-)
D [21/Sep/2014:12:17:24 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [21/Sep/2014:12:17:24 +0200] cupsdMarkDirty(---J-)
D [21/Sep/2014:12:17:24 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [21/Sep/2014:12:17:24 +0200] cupsd is not idle any more, canceling shutdown.
D [21/Sep/2014:12:17:25 +0200] [Job 25] Unloading...
D [21/Sep/2014:12:17:25 +0200] cupsd is not idle any more, canceling shutdown.
-------------- next part --------------
A non-text attachment was scrubbed...
Name: digital_signature_gpg.asc
Type: application/pgp-signature
Size: 1107 bytes
Desc: Digital signature (see http://martin-krafft.net/gpg/sig-policy/999bbcc4/current)
URL: <http://lists.alioth.debian.org/pipermail/pkg-cups-devel/attachments/20140921/0b8094e3/attachment-0001.sig>
More information about the Pkg-cups-devel
mailing list