Bug#736942: marked as done (cups: Printing not working with Konica Minolta C220)

[owner@bugs.debian.org (Debian Bug Tracking System)]

Your message dated Thu, 30 Oct 2014 19:53:15 +0100
with message-id <7702029.0Gx6MV2EEh@gyllingar>
and subject line Re: Bug#736942: cups: Printing not working with Konica Minolta C220
has caused the Debian Bug report #736942,
regarding cups: Printing not working with Konica Minolta C220
to be marked as done.

This means that you claim that the problem has been dealt with.
If this is not the case it is now your responsibility to reopen the
Bug report if necessary, and/or fix the problem forthwith.

(NB: If you are a system administrator and have no idea what this
message is talking about, this may indicate a serious mail system
misconfiguration somewhere. Please contact owner@bugs.debian.org
immediately.)


-- 
736942: http://bugs.debian.org/cgi-bin/bugreport.cgi?bug=736942
Debian Bug Tracking System
Contact owner@bugs.debian.org with problems

--- Begin Message ---

• To: Debian Bug Tracking System <submit@bugs.debian.org>
• Subject: cups: Printing not working with Konica Minolta C220
• From: Oriol Mula-Valls <oriol.mula-valls@ic3.cat>
• Date: Tue, 28 Jan 2014 17:50:48 +0100
• Message-id: <20140128165048.12584.54837.reportbug@freyr.ic3.cat>

Package: cups
Version: 1.5.3-5+deb7u1
Severity: important

Dear Maintainer,
*** Please consider answering these questions, where appropriate ***

   * What led up to the situation?
Upgrading from squeeze to wheezy
   * What exactly did you do (or not do) that was effective (or
     ineffective)?
Printing wasn't working and I tried replacing the ipp backend with ipp14 but
didn't work.
   * What was the outcome of this action?
Error message in printer job history: Deleted Due To Error
   * What outcome did you expect instead?
Document printed

*** End of the template - remove these lines ***



-- System Information:
Debian Release: 7.2
  APT prefers stable
  APT policy: (900, 'stable')
Architecture: amd64 (x86_64)
Foreign Architectures: i386

Kernel: Linux 3.2.0-4-amd64 (SMP w/8 CPU cores)
Locale: LANG=en_GB.UTF-8, LC_CTYPE=en_GB.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash

Versions of packages cups depends on:
ii  adduser                3.113+nmu3
ii  bc                     1.06.95-2+b1
ii  cups-client            1.5.3-5+deb7u1
ii  cups-common            1.5.3-5+deb7u1
ii  cups-filters           1.0.18-2.1
ii  cups-ppdc              1.5.3-5+deb7u1
ii  debconf [debconf-2.0]  1.5.49
ii  dpkg                   1.16.12
ii  ghostscript            9.05~dfsg-6.3+deb7u1
ii  libavahi-client3       0.6.31-2
ii  libavahi-common3       0.6.31-2
ii  libc-bin               2.13-38
ii  libc6                  2.13-38
ii  libcups2               1.5.3-5+deb7u1
ii  libcupscgi1            1.5.3-5+deb7u1
ii  libcupsimage2          1.5.3-5+deb7u1
ii  libcupsmime1           1.5.3-5+deb7u1
ii  libcupsppdc1           1.5.3-5+deb7u1
ii  libdbus-1-3            1.6.8-1+deb7u1
ii  libgcc1                1:4.7.2-5
ii  libgnutls26            2.12.20-7
ii  libgssapi-krb5-2       1.10.1+dfsg-5+deb7u1
ii  libkrb5-3              1.10.1+dfsg-5+deb7u1
ii  libldap-2.4-2          2.4.31-1+nmu2
ii  libpam0g               1.1.3-7.1
ii  libpaper1              1.1.24+nmu2
ii  libslp1                1.2.1-9
ii  libstdc++6             4.7.2-5
ii  libusb-1.0-0           2:1.0.11-1
ii  lsb-base               4.1+Debian8+deb7u1
ii  poppler-utils          0.18.4-6
ii  procps                 1:3.3.3-3
ii  ssl-cert               1.0.32

Versions of packages cups recommends:
ii  avahi-daemon               0.6.31-2
ii  colord                     0.1.21-1
ii  foomatic-filters           4.0.17-1
ii  ghostscript-cups           9.05~dfsg-6.3+deb7u1
ii  printer-driver-gutenprint  5.2.9-1

Versions of packages cups suggests:
ii  cups-bsd               1.5.3-5+deb7u1
pn  cups-pdf               <none>
ii  foomatic-db            20120523-1
ii  hplip                  3.12.6-3.1
ii  printer-driver-hpcups  3.12.6-3.1
ii  smbclient              2:3.6.6-6+deb7u1
ii  udev                   175-7.2

-- debconf information:
  cupsys/raw-print: true
  cupsys/backend: ipp, ipp14, lpd, socket, usb, snmp, dnssd

I [28/Jan/2014:17:36:48 +0100] Saving printers.conf...
I [28/Jan/2014:17:36:48 +0100] Generating printcap /var/run/cups/printcap...
I [28/Jan/2014:17:36:48 +0100] Saving subscriptions.conf...
D [28/Jan/2014:17:36:48 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
I [28/Jan/2014:17:36:48 +0100] Saving job.cache...
W [28/Jan/2014:17:36:49 +0100] Please move "SystemGroup lpadmin" on line 3 of /etc/cups/cupsd.conf to the /etc/cups/cups-files.conf file; this will become an error in a future release.
I [28/Jan/2014:17:36:49 +0100] Listening to [v1.::1]:631 (IPv6)
I [28/Jan/2014:17:36:49 +0100] Listening to 127.0.0.1:631 (IPv4)
I [28/Jan/2014:17:36:49 +0100] Listening to /var/run/cups/cups.sock (Domain)
W [28/Jan/2014:17:36:49 +0100] No limit for Validate-Job defined in policy default and no suitable template found.
W [28/Jan/2014:17:36:49 +0100] No limit for Cancel-Jobs defined in policy default - using Pause-Printer's policy.
W [28/Jan/2014:17:36:49 +0100] No limit for Cancel-My-Jobs defined in policy default - using Send-Document's policy.
W [28/Jan/2014:17:36:49 +0100] No limit for Close-Job defined in policy default - using Send-Document's policy.
W [28/Jan/2014:17:36:49 +0100] No JobPrivateAccess defined in policy default - using defaults.
W [28/Jan/2014:17:36:49 +0100] No JobPrivateValues defined in policy default - using defaults.
W [28/Jan/2014:17:36:49 +0100] No SubscriptionPrivateAccess defined in policy default - using defaults.
W [28/Jan/2014:17:36:49 +0100] No SubscriptionPrivateValues defined in policy default - using defaults.
W [28/Jan/2014:17:36:49 +0100] No limit for Validate-Job defined in policy authenticated - using Print-Job's policy.
W [28/Jan/2014:17:36:49 +0100] No limit for Cancel-Jobs defined in policy authenticated - using Pause-Printer's policy.
W [28/Jan/2014:17:36:49 +0100] No limit for Cancel-My-Jobs defined in policy authenticated - using Send-Document's policy.
W [28/Jan/2014:17:36:49 +0100] No limit for Close-Job defined in policy authenticated - using Send-Document's policy.
W [28/Jan/2014:17:36:49 +0100] No JobPrivateAccess defined in policy authenticated - using defaults.
W [28/Jan/2014:17:36:49 +0100] No JobPrivateValues defined in policy authenticated - using defaults.
W [28/Jan/2014:17:36:49 +0100] No SubscriptionPrivateAccess defined in policy authenticated - using defaults.
W [28/Jan/2014:17:36:49 +0100] No SubscriptionPrivateValues defined in policy authenticated - using defaults.
I [28/Jan/2014:17:36:49 +0100] Remote access is disabled.
D [28/Jan/2014:17:36:49 +0100] Added auto ServerAlias freyr
I [28/Jan/2014:17:36:49 +0100] Loaded configuration file "/etc/cups/cupsd.conf"
I [28/Jan/2014:17:36:49 +0100] Using default TempDir of /var/spool/cups/tmp...
I [28/Jan/2014:17:36:49 +0100] Configured for up to 100 clients.
I [28/Jan/2014:17:36:49 +0100] Allowing up to 100 client connections per host.
I [28/Jan/2014:17:36:49 +0100] Using policy "default" as the default.
I [28/Jan/2014:17:36:49 +0100] Full reload is required.
I [28/Jan/2014:17:36:49 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 40 types, 57 filters...
D [28/Jan/2014:17:36:49 +0100] Loading printer KONICA-MINOLTA-C360SeriesPS-P...
D [28/Jan/2014:17:36:49 +0100] load_ppd: Loading /var/cache/cups/KONICA-MINOLTA-C360SeriesPS-P.data...
D [28/Jan/2014:17:36:49 +0100] Calling DeleteDevice(cups-KONICA-MINOLTA-C360SeriesPS-P)
D [28/Jan/2014:17:36:49 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [28/Jan/2014:17:36:49 +0100] Using profile id of KONICA-MINOLTA-C360SeriesPS-P-Gray..
D [28/Jan/2014:17:36:49 +0100] Calling CreateProfile(KONICA-MINOLTA-C360SeriesPS-P-Gray..,temp)
D [28/Jan/2014:17:36:49 +0100] created profile /org/freedesktop/ColorManager/profiles/KONICA_MINOLTA_C360SeriesPS_P_Gray__
D [28/Jan/2014:17:36:49 +0100] Using profile id of KONICA-MINOLTA-C360SeriesPS-P-CMYK..
D [28/Jan/2014:17:36:49 +0100] Calling CreateProfile(KONICA-MINOLTA-C360SeriesPS-P-CMYK..,temp)
D [28/Jan/2014:17:36:49 +0100] created profile /org/freedesktop/ColorManager/profiles/KONICA_MINOLTA_C360SeriesPS_P_CMYK__
I [28/Jan/2014:17:36:49 +0100] Registering ICC color profiles for "KONICA-MINOLTA-C360SeriesPS-P"
D [28/Jan/2014:17:36:49 +0100] Calling CreateDevice(cups-KONICA-MINOLTA-C360SeriesPS-P,temp)
D [28/Jan/2014:17:36:49 +0100] created device /org/freedesktop/ColorManager/devices/cups_KONICA_MINOLTA_C360SeriesPS_P
D [28/Jan/2014:17:36:49 +0100] Calling /org/freedesktop/ColorManager/devices/cups_KONICA_MINOLTA_C360SeriesPS_P:AddProfile(/org/freedesktop/ColorManager/profiles/KONICA_MINOLTA_C360SeriesPS_P_Gray__) [soft]
D [28/Jan/2014:17:36:49 +0100] Calling /org/freedesktop/ColorManager/devices/cups_KONICA_MINOLTA_C360SeriesPS_P:AddProfile(/org/freedesktop/ColorManager/profiles/KONICA_MINOLTA_C360SeriesPS_P_CMYK__) [soft]
D [28/Jan/2014:17:36:49 +0100] cupsdRegisterPrinter(p=0x7f6e387e4040(KONICA-MINOLTA-C360SeriesPS-P))
D [28/Jan/2014:17:36:49 +0100] load_ppd: Loading /var/cache/cups/KONICA-MINOLTA-C360SeriesPS-P.data...
D [28/Jan/2014:17:36:49 +0100] Calling DeleteDevice(cups-KONICA-MINOLTA-C360SeriesPS-P)
D [28/Jan/2014:17:36:49 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [28/Jan/2014:17:36:49 +0100] Using profile id of KONICA-MINOLTA-C360SeriesPS-P-Gray..
D [28/Jan/2014:17:36:49 +0100] Calling CreateProfile(KONICA-MINOLTA-C360SeriesPS-P-Gray..,temp)
W [28/Jan/2014:17:36:49 +0100] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'KONICA-MINOLTA-C360SeriesPS-P-Gray..' already exists
D [28/Jan/2014:17:36:49 +0100] Using profile id of KONICA-MINOLTA-C360SeriesPS-P-CMYK..
D [28/Jan/2014:17:36:49 +0100] Calling CreateProfile(KONICA-MINOLTA-C360SeriesPS-P-CMYK..,temp)
W [28/Jan/2014:17:36:49 +0100] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'KONICA-MINOLTA-C360SeriesPS-P-CMYK..' already exists
I [28/Jan/2014:17:36:49 +0100] Registering ICC color profiles for "KONICA-MINOLTA-C360SeriesPS-P"
D [28/Jan/2014:17:36:49 +0100] Calling CreateDevice(cups-KONICA-MINOLTA-C360SeriesPS-P,temp)
W [28/Jan/2014:17:36:49 +0100] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-KONICA-MINOLTA-C360SeriesPS-P' already exists
D [28/Jan/2014:17:36:49 +0100] cupsdRegisterPrinter(p=0x7f6e387e4040(KONICA-MINOLTA-C360SeriesPS-P))
I [28/Jan/2014:17:36:49 +0100] Loading job cache file "/var/cache/cups/job.cache"...
D [28/Jan/2014:17:36:49 +0100] [Job 235] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] [Job 236] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] [Job 237] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] [Job 238] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] [Job 239] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] [Job 240] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] [Job 241] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] [Job 242] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] [Job 243] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] [Job 244] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] [Job 245] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] [Job 247] Loading from cache...
D [28/Jan/2014:17:36:49 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [28/Jan/2014:17:36:49 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [28/Jan/2014:17:36:49 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
I [28/Jan/2014:17:36:49 +0100] Full reload complete.
D [28/Jan/2014:17:36:49 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [28/Jan/2014:17:36:49 +0100] Cleaning out old files in "/var/spool/cups/tmp"...
D [28/Jan/2014:17:36:49 +0100] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
I [28/Jan/2014:17:36:49 +0100] Cleaning out old files in "/var/cache/cups"...
I [28/Jan/2014:17:36:49 +0100] Listening to [v1.::1]:631 on fd 9...
I [28/Jan/2014:17:36:49 +0100] Listening to 127.0.0.1:631 on fd 10...
I [28/Jan/2014:17:36:49 +0100] Listening to /var/run/cups/cups.sock:631 on fd 11...
I [28/Jan/2014:17:36:49 +0100] Resuming new connection processing...
D [28/Jan/2014:17:36:49 +0100] cupsdRegisterPrinter(p=0x7f6e387e4040(KONICA-MINOLTA-C360SeriesPS-P))
D [28/Jan/2014:17:36:49 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:49 +0100] Discarding unused server-started event...
D [28/Jan/2014:17:36:50 +0100] Report: clients=0
D [28/Jan/2014:17:36:50 +0100] Report: jobs=12
D [28/Jan/2014:17:36:50 +0100] Report: jobs-active=0
D [28/Jan/2014:17:36:50 +0100] Report: printers=1
D [28/Jan/2014:17:36:50 +0100] Report: printers-implicit=0
D [28/Jan/2014:17:36:50 +0100] Report: stringpool-string-count=15395
D [28/Jan/2014:17:36:50 +0100] Report: stringpool-alloc-bytes=11864
D [28/Jan/2014:17:36:50 +0100] Report: stringpool-total-bytes=275288
D [28/Jan/2014:17:36:55 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:55 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:55 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:55 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:55 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:55 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 15 GET /printers/KONICA-MINOLTA-C360SeriesPS-P.ppd HTTP/1.1
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:55 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:55 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:55 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:55 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:55 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:55 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:55 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:55 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:55 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:55 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:55 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:55 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:55 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:55 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:55 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:55 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:55 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:55 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:55 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:56 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:56 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:56 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:56 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:56 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:56 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:56 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:56 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:56 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:56 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:56 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:56 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:56 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:56 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:56 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:56 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:56 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:56 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:56 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:56 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:56 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:56 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:56 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:56 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:56 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:56 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:56 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:56 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:57 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:57 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:57 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:57 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:57 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:57 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:57 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:57 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:57 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:57 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:57 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:57 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:57 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:57 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:57 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:57 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:57 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:57 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:57 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:57 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Jan/2014:17:36:57 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:36:57 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:36:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:36:58 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 POST /printers/KONICA-MINOLTA-C360SeriesPS-P HTTP/1.1
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Jan/2014:17:36:58 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 1.1 Print-Job 1
D [28/Jan/2014:17:36:58 +0100] Print-Job ipp://localhost:631/printers/KONICA-MINOLTA-C360SeriesPS-P
D [28/Jan/2014:17:36:58 +0100] [Job ???] Auto-typing file...
I [28/Jan/2014:17:36:58 +0100] [Job ???] Request file type is application/pdf.
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(----J-)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [28/Jan/2014:17:36:58 +0100] add_job: requesting-user-name="omula"
I [28/Jan/2014:17:36:58 +0100] [Job 248] Adding start banner page "none".
D [28/Jan/2014:17:36:58 +0100] Discarding unused job-created event...
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(----J-)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [28/Jan/2014:17:36:58 +0100] [Job 248] Adding end banner page "none".
I [28/Jan/2014:17:36:58 +0100] [Job 248] File of type application/pdf queued by "omula".
D [28/Jan/2014:17:36:58 +0100] [Job 248] hold_until=0
I [28/Jan/2014:17:36:58 +0100] [Job 248] Queued on "KONICA-MINOLTA-C360SeriesPS-P" by "omula".
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(----J-)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] job-sheets=none,none
D [28/Jan/2014:17:36:58 +0100] [Job 248] argv[0]="KONICA-MINOLTA-C360SeriesPS-P"
D [28/Jan/2014:17:36:58 +0100] [Job 248] argv[1]="248"
D [28/Jan/2014:17:36:58 +0100] [Job 248] argv[2]="omula"
D [28/Jan/2014:17:36:58 +0100] [Job 248] argv[3]="linuxchecklist.pdf"
D [28/Jan/2014:17:36:58 +0100] [Job 248] argv[4]="1"
D [28/Jan/2014:17:36:58 +0100] [Job 248] argv[5]="noString4Pt OriginalImageType=Document InputSlot=AutoSelect GraphicSmoothing=Auto PaperSources=None FrontCoverTray=None Punch=None Fold=None BackCoverTray=None KOPunch=None GraphicPureBlack=Auto GraphicColorMatching=Auto GraphicScreen=Auto BlackOverPrint=Off TextScreen=Auto noGlossyMode TextPureBlack=Auto noTonerSave PhotoScreen=Auto PageSize=A4 SelectColor=Auto TextColorMatching=Auto SaddleUnit=None MediaType=Plain noOffset KMDuplex=2Sided WaitMode=None number-up=1 OHPOpTray=None PhotoColorMatching=Auto noAutoTrapping FrontCoverPage=None TransparencyInterleave=None PhotoSmoothing=Auto Combination=None BackCoverPage=None Finisher=None Staple=None PhotoPureBlack=Auto Binding=TopBinding OutputBin=Default job-uuid=urn:uuid:9a93c53b-8ba6-32ff-6a38-89c787d8ae46 job-originating-host-name=localhost time-at-creation=1390927018 time-at-processing=1390927018"
D [28/Jan/2014:17:36:58 +0100] [Job 248] argv[6]="/var/spool/cups/d00248-001"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[8]="HOME=/var/spool/cups/tmp"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[10]="SERVER_ADMIN=root@freyr"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[11]="SOFTWARE=CUPS/1.5.3"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[13]="TZ=Europe/Madrid"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[14]="USER=root"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[17]="IPP_PORT=631"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[18]="CHARSET=utf-8"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[19]="LANG=en_GB.UTF-8"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[20]="PPD=/etc/cups/ppd/KONICA-MINOLTA-C360SeriesPS-P.ppd"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[21]="RIP_MAX_CACHE=128m"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[22]="CONTENT_TYPE=application/pdf"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[23]="DEVICE_URI=ipp://192.168.50.2/ipp"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[24]="PRINTER_INFO=KONICA MINOLTA C360SeriesPS/P"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[25]="PRINTER_LOCATION=KMBT6CF574"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[26]="PRINTER=KONICA-MINOLTA-C360SeriesPS-P"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[27]="PRINTER_STATE_REASONS=media-empty-warning"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[28]="CUPS_FILETYPE=document"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [28/Jan/2014:17:36:58 +0100] [Job 248] envp[30]="AUTH_I****"
I [28/Jan/2014:17:36:58 +0100] [Job 248] Started filter /usr/lib/cups/filter/pdftopdf (PID 12516)
I [28/Jan/2014:17:36:58 +0100] [Job 248] Started filter /usr/lib/cups/filter/pdftops (PID 12517)
I [28/Jan/2014:17:36:58 +0100] [Job 248] Started backend /usr/lib/cups/backend/ipp (PID 12518)
D [28/Jan/2014:17:36:58 +0100] Discarding unused job-state-changed event...
D [28/Jan/2014:17:36:58 +0100] Returning IPP successful-ok for Print-Job (ipp://localhost:631/printers/KONICA-MINOLTA-C360SeriesPS-P) from localhost
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:58 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: +connecting-to-device
D [28/Jan/2014:17:36:58 +0100] [Job 248] Looking up "192.168.50.2"...
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
I [28/Jan/2014:17:36:58 +0100] [Job 248] Copying print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Set job-printer-state-message to "Copying print data...", current level=INFO
D [28/Jan/2014:17:36:58 +0100] [Job 248] 
D [28/Jan/2014:17:36:58 +0100] [Job 248] backendRunLoop(print_fd=-1, device_fd=6, snmp_fd=5, addr=0x7f458ffafa88, use_bc=0, side_cb=0x7f458f62de30)
D [28/Jan/2014:17:36:58 +0100] Discarding unused job-progress event...
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] pdftops - copying to temp print file "/var/spool/cups/tmp/030e552eac70c"
D [28/Jan/2014:17:36:58 +0100] PID 12516 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [28/Jan/2014:17:36:58 +0100] [Job 248] Using image rendering resolution 600 dpi
D [28/Jan/2014:17:36:58 +0100] [Job 248] Started filter gs (PID 12519)
D [28/Jan/2014:17:36:58 +0100] [Job 248] Started filter pstops (PID 12520)
D [28/Jan/2014:17:36:58 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 1.1 Get-Notifications 1
D [28/Jan/2014:17:36:58 +0100] Get-Notifications /
D [28/Jan/2014:17:36:58 +0100] cupsdIsAuthorized: requesting-user-name="omula"
D [28/Jan/2014:17:36:58 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [28/Jan/2014:17:36:58 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] Page = 595x842; 12,12 to 583,830
D [28/Jan/2014:17:36:58 +0100] [Job 248] slow_collate=0, slow_duplex=0, slow_order=0
D [28/Jan/2014:17:36:58 +0100] [Job 248] Before copy_comments - %!PS-Adobe-3.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] %!PS-Adobe-3.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] %%BoundingBox: 0 0 595 842
D [28/Jan/2014:17:36:58 +0100] [Job 248] %%Creator: GPL Ghostscript 905 (ps2write)
D [28/Jan/2014:17:36:58 +0100] [Job 248] %%LanguageLevel: 2
D [28/Jan/2014:17:36:58 +0100] [Job 248] %%CreationDate: D:20140128173658+01'00'
D [28/Jan/2014:17:36:58 +0100] [Job 248] %%Pages: 4
D [28/Jan/2014:17:36:58 +0100] [Job 248] %%EndComments
D [28/Jan/2014:17:36:58 +0100] [Job 248] Before copy_prolog - %%BeginProlog
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:58 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:58 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Classes 1
D [28/Jan/2014:17:36:58 +0100] CUPS-Get-Classes
D [28/Jan/2014:17:36:58 +0100] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Default 1
D [28/Jan/2014:17:36:58 +0100] CUPS-Get-Default
D [28/Jan/2014:17:36:58 +0100] CUPS-Get-Default client-error-not-found: No default printer.
D [28/Jan/2014:17:36:58 +0100] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] ATTR: marker-colors=#00FFFF,#FF00FF,#FFFF00,#000000,#00FFFF,#00FFFF,#FF00FF,#FF00FF,#FFFF00,#FFFF00,#000000,#000000,none,none,none,none,none
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] ATTR: marker-names='"Toner (Cyan)"','"Toner (Magenta)"','"Toner (Yellow)"','"Toner (Black)"','"Drum Cartridge (Cyan)"','"Developer Cartridge (Cyan)"','"Drum Cartridge (Magenta)"','"Developer Cartridge (Magenta)"','"Drum Cartridge (Yellow)"','"Developer Cartridge (Yellow)"','"Drum Cartridge (Black)"','"Developer Cartridge (Black)"','"Waste Toner Box"','"Fusing Unit"','"Image Transfer Belt Unit"','"Transfer Roller Unit"','"Ozone Filter"'
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] ATTR: marker-types=toner,toner,toner,toner,opc,developer,opc,developer,opc,developer,opc,developer,wasteToner,fuser,transferUnit,transferUnit,cleanerUnit
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] ATTR: marker-levels=5,28,9,97,9,59,9,59,9,59,47,83,-1,81,65,76,76
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] new_supply_state=40, change_state=ffff
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -developer-low-report
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -developer-empty-warning
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -marker-supply-low-report
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -marker-supply-empty-warning
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -opc-near-eol-report
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -opc-life-over-warning
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: +toner-low-report
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -toner-empty-warning
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] new_state=100, change_state=ffff
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -media-low-report
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -media-empty-warning
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -door-open-report
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -media-jam-warning
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -input-tray-missing-warning
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -output-tray-missing-warning
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -marker-supply-missing-warning
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -output-area-almost-full-report
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -output-area-full-warning
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 8192 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Before copy_setup - %%Page: 1 1
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Before page loop - %%Page: 1 1
D [28/Jan/2014:17:36:58 +0100] [Job 248] Copying page 1...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] PAGE: 1 1
D [28/Jan/2014:17:36:58 +0100] Discarding unused job-progress event...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] pagew = 571.0, pagel = 818.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageLeft = 12.0, PageRight = 583.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageTop = 830.0, PageBottom = 12.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageWidth = 595.0, PageLength = 842.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Copying page 2...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] PAGE: 2 1
D [28/Jan/2014:17:36:58 +0100] Discarding unused job-progress event...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 1203 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 1203 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] pagew = 571.0, pagel = 818.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageLeft = 12.0, PageRight = 583.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageTop = 830.0, PageBottom = 12.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageWidth = 595.0, PageLength = 842.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Copying page 3...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 2709 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] PAGE: 3 1
D [28/Jan/2014:17:36:58 +0100] Discarding unused job-progress event...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 2709 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] pagew = 571.0, pagel = 818.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageLeft = 12.0, PageRight = 583.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageTop = 830.0, PageBottom = 12.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageWidth = 595.0, PageLength = 842.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Copying page 4...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4290 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] PAGE: 4 1
D [28/Jan/2014:17:36:58 +0100] Discarding unused job-progress event...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4290 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] pagew = 571.0, pagel = 818.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageLeft = 12.0, PageRight = 583.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageTop = 830.0, PageBottom = 12.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] PageWidth = 595.0, PageLength = 842.0
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4096 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 4 pages...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 2569 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 2569 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Read 55 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Wrote 55 bytes of print data...
D [28/Jan/2014:17:36:58 +0100] [Job 248] PID 12520 (pstops) exited with no errors.
D [28/Jan/2014:17:36:58 +0100] [Job 248] PID 12519 (gs) exited with no errors.
D [28/Jan/2014:17:36:58 +0100] PID 12517 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [28/Jan/2014:17:36:58 +0100] [Job 248] 1 files to send in job...
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: +connecting-to-device
D [28/Jan/2014:17:36:58 +0100] [Job 248] Connecting to 192.168.50.2:631
I [28/Jan/2014:17:36:58 +0100] [Job 248] Connecting to printer...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Set job-printer-state-message to "Connecting to printer...", current level=INFO
D [28/Jan/2014:17:36:58 +0100] [Job 248] 
D [28/Jan/2014:17:36:58 +0100] Discarding unused job-progress event...
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] STATE: -connecting-to-device
I [28/Jan/2014:17:36:58 +0100] [Job 248] Connected to printer...
D [28/Jan/2014:17:36:58 +0100] [Job 248] Set job-printer-state-message to "Connected to printer...", current level=INFO
D [28/Jan/2014:17:36:58 +0100] [Job 248] 
D [28/Jan/2014:17:36:58 +0100] Discarding unused job-progress event...
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] Connected to 192.168.50.2:631 (IPv4)...
D [28/Jan/2014:17:36:58 +0100] [Job 248] ATTR: marker-levels=5,28,9,97,9,59,9,59,9,59,47,82,-1,81,64,76,76
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] new_supply_state=40, change_state=0
D [28/Jan/2014:17:36:58 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:58 +0100] [Job 248] new_state=100, change_state=0
D [28/Jan/2014:17:36:58 +0100] [Job 248] Getting supported attributes...
D [28/Jan/2014:17:36:58 +0100] cupsdAcceptClient: 17 from localhost (Domain)
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 17 POST / HTTP/1.1
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:58 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:58 +0100] cupsdReadClient: 17 1.1 Get-Notifications 1
D [28/Jan/2014:17:36:58 +0100] Get-Notifications /
D [28/Jan/2014:17:36:58 +0100] cupsdIsAuthorized: requesting-user-name="omula"
D [28/Jan/2014:17:36:58 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [28/Jan/2014:17:36:58 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Jan/2014:17:36:59 +0100] [Job 248] document-format-supported (6 values)
D [28/Jan/2014:17:36:59 +0100] [Job 248] [0] = "text/html"
D [28/Jan/2014:17:36:59 +0100] [Job 248] [1] = "text/plain"
D [28/Jan/2014:17:36:59 +0100] [Job 248] [2] = "application/postscript"
D [28/Jan/2014:17:36:59 +0100] [Job 248] [3] = "application/vnd.hp-PCL"
D [28/Jan/2014:17:36:59 +0100] [Job 248] [4] = "application/pdf"
D [28/Jan/2014:17:36:59 +0100] [Job 248] [5] = "application/octet-stream"
I [28/Jan/2014:17:36:59 +0100] [Job 248] 
D [28/Jan/2014:17:36:59 +0100] [Job 248] Set job-printer-state-message to "Connected to printer...", current level=INFO
D [28/Jan/2014:17:36:59 +0100] [Job 248] STATE: media-empty-warning
D [28/Jan/2014:17:36:59 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] [Job 248] printer-uri = "ipp://192.168.50.2:631/ipp"
D [28/Jan/2014:17:36:59 +0100] [Job 248] requesting-user-name = "omula"
D [28/Jan/2014:17:36:59 +0100] [Job 248] job-name = "linuxchecklist.pdf"
D [28/Jan/2014:17:36:59 +0100] Discarding unused job-progress event...
D [28/Jan/2014:17:36:59 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] Avahi client started
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 17 WAITING Closing on EOF
D [28/Jan/2014:17:36:59 +0100] cupsdCloseClient: 17
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:59 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:59 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Classes 1
D [28/Jan/2014:17:36:59 +0100] CUPS-Get-Classes
D [28/Jan/2014:17:36:59 +0100] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Default 1
D [28/Jan/2014:17:36:59 +0100] CUPS-Get-Default
D [28/Jan/2014:17:36:59 +0100] CUPS-Get-Default client-error-not-found: No default printer.
D [28/Jan/2014:17:36:59 +0100] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdAcceptClient: 17 from localhost (Domain)
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 17 POST / HTTP/1.1
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 17 1.1 Get-Notifications 1
D [28/Jan/2014:17:36:59 +0100] Get-Notifications /
D [28/Jan/2014:17:36:59 +0100] cupsdIsAuthorized: requesting-user-name="omula"
D [28/Jan/2014:17:36:59 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 17 WAITING Closing on EOF
D [28/Jan/2014:17:36:59 +0100] cupsdCloseClient: 17
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:36:59 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:36:59 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Classes 1
D [28/Jan/2014:17:36:59 +0100] CUPS-Get-Classes
D [28/Jan/2014:17:36:59 +0100] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:36:59 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:36:59 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Default 1
D [28/Jan/2014:17:36:59 +0100] CUPS-Get-Default
D [28/Jan/2014:17:36:59 +0100] CUPS-Get-Default client-error-not-found: No default printer.
D [28/Jan/2014:17:36:59 +0100] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [28/Jan/2014:17:36:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
N [28/Jan/2014:17:37:00 +0100] [Job 248] Print file accepted - job ID 24628.
D [28/Jan/2014:17:37:00 +0100] [Job 248] Set job-printer-state-message to "Print file accepted - job ID 24628.", current level=INFO
D [28/Jan/2014:17:37:00 +0100] [Job 248] 
I [28/Jan/2014:17:37:00 +0100] [Job 248] Waiting for job to complete...
D [28/Jan/2014:17:37:00 +0100] [Job 248] Set job-printer-state-message to "Waiting for job to complete...", current level=INFO
D [28/Jan/2014:17:37:00 +0100] [Job 248] 
D [28/Jan/2014:17:37:00 +0100] Discarding unused job-progress event...
D [28/Jan/2014:17:37:00 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdAcceptClient: 17 from localhost (Domain)
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 17 POST / HTTP/1.1
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 17 1.1 Get-Notifications 1
D [28/Jan/2014:17:37:00 +0100] Get-Notifications /
D [28/Jan/2014:17:37:00 +0100] cupsdIsAuthorized: requesting-user-name="omula"
D [28/Jan/2014:17:37:00 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 17 WAITING Closing on EOF
D [28/Jan/2014:17:37:00 +0100] cupsdCloseClient: 17
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
I [28/Jan/2014:17:37:00 +0100] [Job 248] 
D [28/Jan/2014:17:37:00 +0100] [Job 248] Set job-printer-state-message to "Waiting for job to complete...", current level=INFO
D [28/Jan/2014:17:37:00 +0100] [Job 248] STATE: media-empty-warning
D [28/Jan/2014:17:37:00 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] Discarding unused job-progress event...
D [28/Jan/2014:17:37:00 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:37:00 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:37:00 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Classes 1
D [28/Jan/2014:17:37:00 +0100] CUPS-Get-Classes
D [28/Jan/2014:17:37:00 +0100] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Default 1
D [28/Jan/2014:17:37:00 +0100] CUPS-Get-Default
D [28/Jan/2014:17:37:00 +0100] CUPS-Get-Default client-error-not-found: No default printer.
D [28/Jan/2014:17:37:00 +0100] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Jan/2014:17:37:00 +0100] [Job 248] ATTR: marker-levels=5,28,9,97,9,59,9,59,9,59,47,82,-1,81,64,76,76
D [28/Jan/2014:17:37:00 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] [Job 248] new_supply_state=40, change_state=0
D [28/Jan/2014:17:37:00 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] [Job 248] new_state=100, change_state=0
D [28/Jan/2014:17:37:00 +0100] [Job 248] ATTR: auth-info-required=none
D [28/Jan/2014:17:37:00 +0100] load_ppd: Loading /var/cache/cups/KONICA-MINOLTA-C360SeriesPS-P.data...
D [28/Jan/2014:17:37:00 +0100] Calling DeleteDevice(cups-KONICA-MINOLTA-C360SeriesPS-P)
D [28/Jan/2014:17:37:00 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [28/Jan/2014:17:37:00 +0100] Using profile id of KONICA-MINOLTA-C360SeriesPS-P-Gray..
D [28/Jan/2014:17:37:00 +0100] Calling CreateProfile(KONICA-MINOLTA-C360SeriesPS-P-Gray..,temp)
W [28/Jan/2014:17:37:00 +0100] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'KONICA-MINOLTA-C360SeriesPS-P-Gray..' already exists
D [28/Jan/2014:17:37:00 +0100] Using profile id of KONICA-MINOLTA-C360SeriesPS-P-CMYK..
D [28/Jan/2014:17:37:00 +0100] Calling CreateProfile(KONICA-MINOLTA-C360SeriesPS-P-CMYK..,temp)
W [28/Jan/2014:17:37:00 +0100] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'KONICA-MINOLTA-C360SeriesPS-P-CMYK..' already exists
I [28/Jan/2014:17:37:00 +0100] Registering ICC color profiles for "KONICA-MINOLTA-C360SeriesPS-P"
D [28/Jan/2014:17:37:00 +0100] Calling CreateDevice(cups-KONICA-MINOLTA-C360SeriesPS-P,temp)
W [28/Jan/2014:17:37:00 +0100] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-KONICA-MINOLTA-C360SeriesPS-P' already exists
D [28/Jan/2014:17:37:00 +0100] cupsdRegisterPrinter(p=0x7f6e387e4040(KONICA-MINOLTA-C360SeriesPS-P))
D [28/Jan/2014:17:37:00 +0100] cupsdMarkDirty(P-----)
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
I [28/Jan/2014:17:37:00 +0100] [Job 248] Ready to print.
D [28/Jan/2014:17:37:00 +0100] [Job 248] Set job-printer-state-message to "Ready to print.", current level=INFO
D [28/Jan/2014:17:37:00 +0100] [Job 248] 
D [28/Jan/2014:17:37:00 +0100] Discarding unused job-progress event...
D [28/Jan/2014:17:37:00 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] PID 12518 (/usr/lib/cups/backend/ipp) exited with no errors.
D [28/Jan/2014:17:37:00 +0100] Discarding unused job-completed event...
I [28/Jan/2014:17:37:00 +0100] [Job 248] Job completed.
D [28/Jan/2014:17:37:00 +0100] cupsdMarkDirty(----J-)
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdMarkDirty(-----S)
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [28/Jan/2014:17:37:00 +0100] Get-Notifications /
D [28/Jan/2014:17:37:00 +0100] cupsdIsAuthorized: requesting-user-name="omula"
D [28/Jan/2014:17:37:00 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [28/Jan/2014:17:37:00 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [28/Jan/2014:17:37:00 +0100] cupsdCloseClient: 16
D [28/Jan/2014:17:37:00 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [28/Jan/2014:17:37:01 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:37:01 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [28/Jan/2014:17:37:01 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:37:01 +0100] [Job 248] Unloading...
D [28/Jan/2014:17:37:01 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [28/Jan/2014:17:37:01 +0100] CUPS-Get-Printers
D [28/Jan/2014:17:37:01 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Jan/2014:17:37:01 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [28/Jan/2014:17:37:01 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:37:01 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [28/Jan/2014:17:37:01 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:37:01 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Classes 1
D [28/Jan/2014:17:37:01 +0100] CUPS-Get-Classes
D [28/Jan/2014:17:37:01 +0100] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [28/Jan/2014:17:37:01 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [28/Jan/2014:17:37:01 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [28/Jan/2014:17:37:01 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [28/Jan/2014:17:37:01 +0100] cupsdAuthorize: No authentication data provided.
D [28/Jan/2014:17:37:01 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Default 1
D [28/Jan/2014:17:37:01 +0100] CUPS-Get-Default
D [28/Jan/2014:17:37:01 +0100] CUPS-Get-Default client-error-not-found: No default printer.
D [28/Jan/2014:17:37:01 +0100] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [28/Jan/2014:17:37:01 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
I [28/Jan/2014:17:37:29 +0100] Saving printers.conf...
I [28/Jan/2014:17:37:29 +0100] Saving job.cache...
I [28/Jan/2014:17:37:29 +0100] Saving subscriptions.conf...
D [28/Jan/2014:17:37:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [28/Jan/2014:17:42:02 +0100] Closing client 15 after 300 seconds of inactivity...
D [28/Jan/2014:17:42:02 +0100] cupsdCloseClient: 15
D [28/Jan/2014:17:42:02 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Jan/2014:17:42:02 +0100] Report: clients=0
D [28/Jan/2014:17:42:02 +0100] Report: jobs=13
D [28/Jan/2014:17:42:02 +0100] Report: jobs-active=0
D [28/Jan/2014:17:42:02 +0100] Report: printers=1
D [28/Jan/2014:17:42:02 +0100] Report: printers-implicit=0
D [28/Jan/2014:17:42:02 +0100] Report: stringpool-string-count=16273
D [28/Jan/2014:17:42:02 +0100] Report: stringpool-alloc-bytes=12536
D [28/Jan/2014:17:42:02 +0100] Report: stringpool-total-bytes=296784

--- End Message ---

--- Begin Message ---

• To: 736942-done@bugs.debian.org
• Subject: Re: Bug#736942: cups: Printing not working with Konica Minolta C220
• From: Didier 'OdyX' Raboud <odyx@debian.org>
• Date: Thu, 30 Oct 2014 19:53:15 +0100
• Message-id: <7702029.0Gx6MV2EEh@gyllingar>
• In-reply-to: <52E96547.9070700@gmail.com>
• References: <20140128165048.12584.54837.reportbug@freyr.ic3.cat> <29012014144938.657da319c99b@desktop.copernicus.demon.co.uk> <52E96547.9070700@gmail.com>

Version: 1.0.41-1

Le mercredi, 29 janvier 2014, 21.32:07 Till Kamppeter a écrit :
> Should be fixed in cups-filters 1.0.40 and later:
> 
> [...]
> CHANGES IN V1.0.40
> 
>         - pdftops: Introduced new "hybrid" renderer: Here usually
>           Ghostscript is used, but if the printer is a Brother,
>           Minolta, or Konica Minolta Poppler's pdftops gets used. This
>           is a quirk rule to work around bugs in the PS interpreters
>           of the printers.

Closing as fixed in 1.0.41-1 then, thanks.

Cheers, OdyX

--- End Message ---