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@d.o> @martinkrafft : :' : proud Debian developer `. `'` http://people.debian.org/~madduck `- Debian - when you have better things to do than fixing systems
_stdin_.pdf
Description: Adobe PDF document
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@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.
digital_signature_gpg.asc
Description: Digital signature (see http://martin-krafft.net/gpg/sig-policy/999bbcc4/current)