[Date Prev][Date Next] [Thread Prev][Thread Next] [Date Index] [Thread Index]

Bug#736089: marked as done (cups-client: Modifying or reinstalling a queue with lpadmin is unreliable)

Your message dated Tue, 07 Jul 2015 21:58:12 +0200
with message-id <2131087.aanBy5t1Hb@gyllingar>
and subject line Re: Bug#736089: cups-client: Modifying or reinstalling a queue with lpadmin is unreliable
has caused the Debian Bug report #736089,
regarding cups-client: Modifying or reinstalling a queue with lpadmin is unreliable
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.)


-- 
736089: http://bugs.debian.org/cgi-bin/bugreport.cgi?bug=736089
Debian Bug Tracking System
Contact owner@bugs.debian.org with problems
--- Begin Message --- 
Package: cups-client
Version: 1.7.1-2
Severity: important



1. A print queue was created on an up-to-date Sid machine with

     lpadmin -p test -v file:/dev/null -m drv:///hpijs.drv/hp-deskjet_f300_series-hpijs.ppd

2. A request to modify the queue was issued with

     lpadmin -p test -v file:/dev/null -m drv:///hpcups.drv/hp-deskjet_f300_series.ppd

   A check of the contents of /etc/cupps/ppd/test revealed that the PPD
   had been changed.

3. A second request to modify the queue was made with

     lpadmin -p test -v file:/dev/null -m drv:///hpijs.drv/hp-deskjet_f300_series-hpijs.ppd

   This time /etc/cupps/ppd/test was unchanged.

4. Repeating 3. resulted in a change in /etc/cupps/ppd/test.

An error log is attached. Portions of the log for queue installation and
successful modification have 

  D [19/Jan/2014:15:17:09 +0000] [Client 16] 2.0 CUPS-Add-Modify-Printer 2
  D [19/Jan/2014:15:17:09 +0000] CUPS-Add-Modify-Printer ipp://localhost:631/printers/test
  D [19/Jan/2014:15:17:09 +0000] cupsdIsAuthorized: username="root"
  D [19/Jan/2014:15:17:09 +0000] test device-uri: OK
  I [19/Jan/2014:15:17:09 +0000] Setting test device-uri to "file:/dev/null" (was "file:///dev/null".)
  D [19/Jan/2014:15:17:09 +0000] copy_model: Running "cups-driverd cat drv:///hpijs.drv/hp-deskjet_f300_series-hpijs.ppd"...
  D [19/Jan/2014:15:17:10 +0000] Copied PPD file successfully

or

  D [19/Jan/2014:15:17:34 +0000] [Client 16] 2.0 CUPS-Add-Modify-Printer 2
  D [19/Jan/2014:15:17:34 +0000] CUPS-Add-Modify-Printer ipp://localhost:631/printers/test
  D [19/Jan/2014:15:17:34 +0000] cupsdIsAuthorized: username="root"
  D [19/Jan/2014:15:17:34 +0000] test device-uri: OK
  I [19/Jan/2014:15:17:34 +0000] Setting test device-uri to "file:/dev/null" (was "file:/dev/null".)
  D [19/Jan/2014:15:17:34 +0000] copy_model: Running "cups-driverd cat drv:///hpcups.drv/hp-deskjet_f300_series.ppd"...
  D [19/Jan/2014:15:17:34 +0000] Copied PPD file successfully

For an unsucessful modification we have

  D [19/Jan/2014:15:18:00 +0000] [Client 16] 2.0 CUPS-Add-Modify-Printer 2
  D [19/Jan/2014:15:18:00 +0000] CUPS-Add-Modify-Printer ipp://localhost:631/printers/test
  D [19/Jan/2014:15:18:00 +0000] cupsdIsAuthorized: username="root"
  D [19/Jan/2014:15:18:00 +0000] test device-uri: OK
  I [19/Jan/2014:15:18:00 +0000] Setting test device-uri to "file:/dev/null" (was "file:/dev/null".)
  D [19/Jan/2014:15:18:00 +0000] Copied PPD file successfully

where we see cups-driverd has not been run.


Further observations.
---------------------

(a) Reinstalling a queue is also only successful every second try.

(b) The described behaviour is exhibited on Wheezy.

(c) With a Fedora Live image (CUPS 1.7.0) lpadmin behaves as expected.

(d) On Squeeze lpadmin also behaves as expected.

(e) The ppd_updater function in cups.postinst uses lpadmin.

Regards,

Brian.

I [19/Jan/2014:15:17:01 +0000] Saving printers.conf...
I [19/Jan/2014:15:17:01 +0000] Generating printcap /var/run/cups/printcap...
D [19/Jan/2014:15:17:01 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
I [19/Jan/2014:15:17:01 +0000] Saving job.cache...
D [19/Jan/2014:15:17:01 +0000] cupsdStopSelect()
E [19/Jan/2014:15:17:01 +0000] Unknown directive BrowseAddress on line 8 of /etc/cups/cupsd.conf.
I [19/Jan/2014:15:17:01 +0000] Please move "FileDevice yes" on line 86 of /etc/cups/cupsd.conf to the /etc/cups/cups-files.conf file; this will become an error in a future release.
I [19/Jan/2014:15:17:01 +0000] Remote access is enabled.
D [19/Jan/2014:15:17:01 +0000] Added auto ServerAlias desktop3
I [19/Jan/2014:15:17:01 +0000] Loaded configuration file "/etc/cups/cupsd.conf"
I [19/Jan/2014:15:17:01 +0000] Using default TempDir of /var/spool/cups/tmp...
I [19/Jan/2014:15:17:01 +0000] Configured for up to 100 clients.
I [19/Jan/2014:15:17:01 +0000] Allowing up to 100 client connections per host.
I [19/Jan/2014:15:17:01 +0000] Using policy "default" as the default.
I [19/Jan/2014:15:17:01 +0000] Full reload is required.
I [19/Jan/2014:15:17:01 +0000] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 39 types, 53 filters...
D [19/Jan/2014:15:17:01 +0000] Loading printer CUPS-PDF...
D [19/Jan/2014:15:17:01 +0000] load_ppd: Loading /var/cache/cups/CUPS-PDF.data...
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb859db90(CUPS-PDF))
D [19/Jan/2014:15:17:01 +0000] Loading printer CUPSout...
D [19/Jan/2014:15:17:01 +0000] load_ppd: Loading /var/cache/cups/CUPSout.data...
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb85a16c0(CUPSout))
D [19/Jan/2014:15:17:01 +0000] Loading printer PDF...
D [19/Jan/2014:15:17:01 +0000] load_ppd: Loading /var/cache/cups/PDF.data...
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb85b0e40(PDF))
D [19/Jan/2014:15:17:01 +0000] Loading printer PDFprinter...
D [19/Jan/2014:15:17:01 +0000] load_ppd: Loading /var/cache/cups/PDFprinter.data...
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb85b60e0(PDFprinter))
D [19/Jan/2014:15:17:01 +0000] Loading printer testprinter...
D [19/Jan/2014:15:17:01 +0000] load_ppd: Loading /var/cache/cups/testprinter.data...
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb85d9958(testprinter))
D [19/Jan/2014:15:17:01 +0000] Loading printer XXXX...
D [19/Jan/2014:15:17:01 +0000] load_ppd: Loading /var/cache/cups/XXXX.data...
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb85dd6c8(XXXX))
I [19/Jan/2014:15:17:01 +0000] Loading job cache file "/var/cache/cups/job.cache"...
D [19/Jan/2014:15:17:01 +0000] [Job 1131] Loading from cache...
D [19/Jan/2014:15:17:01 +0000] [Job 1132] Loading from cache...
D [19/Jan/2014:15:17:01 +0000] [Job 1133] Loading from cache...
I [19/Jan/2014:15:17:01 +0000] Full reload complete.
D [19/Jan/2014:15:17:01 +0000] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [19/Jan/2014:15:17:01 +0000] Cleaning out old files in "/var/spool/cups/tmp".
D [19/Jan/2014:15:17:01 +0000] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
I [19/Jan/2014:15:17:01 +0000] Cleaning out old files in "/var/cache/cups".
D [19/Jan/2014:15:17:01 +0000] Calling FindDeviceById(cups-CUPS-PDF)
D [19/Jan/2014:15:17:01 +0000] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Using profile ID "CUPS-PDF-Gray..".
D [19/Jan/2014:15:17:01 +0000] Calling CreateProfile(CUPS-PDF-Gray..,temp)
W [19/Jan/2014:15:17:01 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Using profile ID "CUPS-PDF-RGB..".
D [19/Jan/2014:15:17:01 +0000] Calling CreateProfile(CUPS-PDF-RGB..,temp)
W [19/Jan/2014:15:17:01 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Jan/2014:15:17:01 +0000] Registering ICC color profiles for "CUPS-PDF".
D [19/Jan/2014:15:17:01 +0000] Calling CreateDevice(cups-CUPS-PDF,temp)
W [19/Jan/2014:15:17:01 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Calling FindDeviceById(cups-CUPSout)
D [19/Jan/2014:15:17:01 +0000] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Using profile ID "CUPSout-Gray..".
D [19/Jan/2014:15:17:01 +0000] Calling CreateProfile(CUPSout-Gray..,temp)
W [19/Jan/2014:15:17:01 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Using profile ID "CUPSout-CMYK..".
D [19/Jan/2014:15:17:01 +0000] Calling CreateProfile(CUPSout-CMYK..,temp)
W [19/Jan/2014:15:17:01 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Jan/2014:15:17:01 +0000] Registering ICC color profiles for "CUPSout".
D [19/Jan/2014:15:17:01 +0000] Calling CreateDevice(cups-CUPSout,temp)
W [19/Jan/2014:15:17:01 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Calling FindDeviceById(cups-PDF)
D [19/Jan/2014:15:17:01 +0000] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Using profile ID "PDF-Gray..".
D [19/Jan/2014:15:17:01 +0000] Calling CreateProfile(PDF-Gray..,temp)
W [19/Jan/2014:15:17:01 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Using profile ID "PDF-RGB..".
D [19/Jan/2014:15:17:01 +0000] Calling CreateProfile(PDF-RGB..,temp)
W [19/Jan/2014:15:17:01 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Jan/2014:15:17:01 +0000] Registering ICC color profiles for "PDF".
D [19/Jan/2014:15:17:01 +0000] Calling CreateDevice(cups-PDF,temp)
W [19/Jan/2014:15:17:01 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Calling FindDeviceById(cups-PDFprinter)
D [19/Jan/2014:15:17:01 +0000] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Using profile ID "PDFprinter-Gray..".
D [19/Jan/2014:15:17:01 +0000] Calling CreateProfile(PDFprinter-Gray..,temp)
W [19/Jan/2014:15:17:01 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Using profile ID "PDFprinter-CMYK..".
D [19/Jan/2014:15:17:01 +0000] Calling CreateProfile(PDFprinter-CMYK..,temp)
W [19/Jan/2014:15:17:01 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Jan/2014:15:17:01 +0000] Registering ICC color profiles for "PDFprinter".
D [19/Jan/2014:15:17:01 +0000] Calling CreateDevice(cups-PDFprinter,temp)
W [19/Jan/2014:15:17:01 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Calling FindDeviceById(cups-testprinter)
D [19/Jan/2014:15:17:01 +0000] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Using profile ID "testprinter-Gray..".
D [19/Jan/2014:15:17:01 +0000] Calling CreateProfile(testprinter-Gray..,temp)
W [19/Jan/2014:15:17:01 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Jan/2014:15:17:01 +0000] Registering ICC color profiles for "testprinter".
D [19/Jan/2014:15:17:01 +0000] Calling CreateDevice(cups-testprinter,temp)
W [19/Jan/2014:15:17:01 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Calling FindDeviceById(cups-XXXX)
D [19/Jan/2014:15:17:01 +0000] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:01 +0000] Using profile ID "XXXX-Gray..".
D [19/Jan/2014:15:17:01 +0000] Calling CreateProfile(XXXX-Gray..,temp)
W [19/Jan/2014:15:17:01 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Jan/2014:15:17:01 +0000] Registering ICC color profiles for "XXXX".
D [19/Jan/2014:15:17:01 +0000] Calling CreateDevice(cups-XXXX,temp)
W [19/Jan/2014:15:17:01 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Jan/2014:15:17:01 +0000] Listening to 0.0.0.0:631 on fd 10...
I [19/Jan/2014:15:17:01 +0000] Listening to [v1.::]:631 on fd 11...
I [19/Jan/2014:15:17:01 +0000] Listening to /var/run/cups/cups.sock:631 on fd 12...
I [19/Jan/2014:15:17:01 +0000] Resuming new connection processing...
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb859db90(CUPS-PDF))
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb85a16c0(CUPSout))
D [19/Jan/2014:15:17:01 +0000] Registering "CUPSout @ desktop3" with DNS-SD type "_printer._tcp".
D [19/Jan/2014:15:17:01 +0000] Registering "CUPSout @ desktop3" with DNS-SD type "_ipps._tcp".
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" printer-type=0x101E
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" printer-state=5
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" Duplex=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" Color=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" TLS=1.2
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" UUID=4631a430-6b90-3dfa-6708-b7c3e7fc678c
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" URF=DM3
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" product=(Generic PDF Printer)
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" priority=0
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" adminurl=https://desktop3.local:631/printers/CUPSout
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" ty=Generic PDF Printer
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" rp=printers/CUPSout
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" qtotal=1
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" txtvers=1
D [19/Jan/2014:15:17:01 +0000] Registering "CUPSout @ desktop3" with DNS-SD type "_ipp._tcp".
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" printer-type=0x101E
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" printer-state=5
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" Duplex=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" Color=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" TLS=1.2
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" UUID=4631a430-6b90-3dfa-6708-b7c3e7fc678c
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" URF=DM3
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" product=(Generic PDF Printer)
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" priority=0
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" adminurl=https://desktop3.local:631/printers/CUPSout
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" ty=Generic PDF Printer
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" rp=printers/CUPSout
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" qtotal=1
D [19/Jan/2014:15:17:01 +0000] DNS_SD "CUPSout @ desktop3" txtvers=1
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb85b0e40(PDF))
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb85b60e0(PDFprinter))
D [19/Jan/2014:15:17:01 +0000] Registering "Print to PDF @ desktop3" with DNS-SD type "_printer._tcp".
D [19/Jan/2014:15:17:01 +0000] Registering "Print to PDF @ desktop3" with DNS-SD type "_ipps._tcp".
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" printer-type=0x101E
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" printer-state=5
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" Duplex=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" Color=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" TLS=1.2
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" UUID=9e39483d-54b7-30fb-43b3-1de19b4f48f6
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" URF=DM3
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" product=(Generic PDF Printer)
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" priority=0
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" note=Emailed
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" adminurl=https://desktop3.local:631/printers/PDFprinter
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" ty=Generic PDF Printer
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" rp=printers/PDFprinter
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" qtotal=1
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" txtvers=1
D [19/Jan/2014:15:17:01 +0000] Registering "Print to PDF @ desktop3" with DNS-SD type "_ipp._tcp".
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" printer-type=0x101E
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" printer-state=5
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" Duplex=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" Color=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" TLS=1.2
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" UUID=9e39483d-54b7-30fb-43b3-1de19b4f48f6
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" URF=DM3
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" product=(Generic PDF Printer)
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" priority=0
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" note=Emailed
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" adminurl=https://desktop3.local:631/printers/PDFprinter
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" ty=Generic PDF Printer
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" rp=printers/PDFprinter
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" qtotal=1
D [19/Jan/2014:15:17:01 +0000] DNS_SD "Print to PDF @ desktop3" txtvers=1
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb85d9958(testprinter))
D [19/Jan/2014:15:17:01 +0000] cupsdRegisterPrinter(p=0xb85dd6c8(XXXX))
D [19/Jan/2014:15:17:01 +0000] Registering "XXXX @ desktop3" with DNS-SD type "_printer._tcp".
D [19/Jan/2014:15:17:01 +0000] Registering "XXXX @ desktop3" with DNS-SD type "_ipps._tcp".
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" printer-type=0x809056
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" printer-state=3
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" Copies=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" Duplex=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" TLS=1.2
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" UUID=dea264df-f1c2-3eff-775b-d5efdd732712
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" URF=DM3
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" product=(FS-1300D)
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" priority=0
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" adminurl=https://desktop3.local:631/printers/XXXX
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" ty=Kyocera FS-1300D (KPDL)
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" rp=printers/XXXX
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" qtotal=1
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" txtvers=1
D [19/Jan/2014:15:17:01 +0000] Registering "XXXX @ desktop3" with DNS-SD type "_ipp._tcp".
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" printer-type=0x809056
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" printer-state=3
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" Copies=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" Duplex=T
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" TLS=1.2
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" UUID=dea264df-f1c2-3eff-775b-d5efdd732712
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" URF=DM3
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" product=(FS-1300D)
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" priority=0
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" adminurl=https://desktop3.local:631/printers/XXXX
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" ty=Kyocera FS-1300D (KPDL)
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" rp=printers/XXXX
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" qtotal=1
D [19/Jan/2014:15:17:01 +0000] DNS_SD "XXXX @ desktop3" txtvers=1
D [19/Jan/2014:15:17:01 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [19/Jan/2014:15:17:01 +0000] Discarding unused server-started event...
D [19/Jan/2014:15:17:02 +0000] Report: clients=0
D [19/Jan/2014:15:17:02 +0000] Report: jobs=3
D [19/Jan/2014:15:17:02 +0000] Report: jobs-active=0
D [19/Jan/2014:15:17:02 +0000] Report: printers=6
D [19/Jan/2014:15:17:02 +0000] Report: stringpool-string-count=20633
D [19/Jan/2014:15:17:02 +0000] Report: stringpool-alloc-bytes=16008
D [19/Jan/2014:15:17:02 +0000] Report: stringpool-total-bytes=378736
D [19/Jan/2014:15:17:09 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:17:09 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:17:09 +0000] [Client 16] POST / HTTP/1.1
D [19/Jan/2014:15:17:09 +0000] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [19/Jan/2014:15:17:09 +0000] [Client 16] No authentication data provided.
D [19/Jan/2014:15:17:09 +0000] [Client 16] 2.0 Get-Printer-Attributes 1
D [19/Jan/2014:15:17:09 +0000] Get-Printer-Attributes ipp://localhost:631/printers/test
D [19/Jan/2014:15:17:09 +0000] Get-Printer-Attributes client-error-not-found: The printer or class does not exist.
D [19/Jan/2014:15:17:09 +0000] [Client 16] Returning IPP client-error-not-found for Get-Printer-Attributes (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:17:09 +0000] [Client 16] Content-Length: 130
D [19/Jan/2014:15:17:09 +0000] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=130, response=0xb86c1270(IPP_IDLE), pipe_pid=0, file=-1
D [19/Jan/2014:15:17:09 +0000] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Jan/2014:15:17:09 +0000] [Client 16] bytes=0, http_state=0, data_remaining=0
D [19/Jan/2014:15:17:09 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:17:09 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [19/Jan/2014:15:17:09 +0000] [Client 17] Accepted from localhost (Domain)
D [19/Jan/2014:15:17:09 +0000] [Client 17] Waiting for request.
D [19/Jan/2014:15:17:09 +0000] [Client 17] POST /printers/test HTTP/1.1
D [19/Jan/2014:15:17:09 +0000] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [19/Jan/2014:15:17:09 +0000] [Client 17] No authentication data provided.
D [19/Jan/2014:15:17:09 +0000] [Client 17] 2.0 Get-Printer-Attributes 3
D [19/Jan/2014:15:17:09 +0000] Get-Printer-Attributes ipp://localhost/printers/test
D [19/Jan/2014:15:17:09 +0000] Get-Printer-Attributes client-error-not-found: The printer or class does not exist.
D [19/Jan/2014:15:17:09 +0000] [Client 17] Returning IPP client-error-not-found for Get-Printer-Attributes (ipp://localhost/printers/test) from localhost
D [19/Jan/2014:15:17:09 +0000] [Client 17] Content-Length: 130
D [19/Jan/2014:15:17:09 +0000] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=130, response=0xb86c1270(IPP_IDLE), pipe_pid=0, file=-1
D [19/Jan/2014:15:17:09 +0000] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Jan/2014:15:17:09 +0000] [Client 17] bytes=0, http_state=0, data_remaining=0
D [19/Jan/2014:15:17:09 +0000] [Client 17] Waiting for request.
D [19/Jan/2014:15:17:09 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [19/Jan/2014:15:17:09 +0000] [Client 16] POST /admin/ HTTP/1.1
D [19/Jan/2014:15:17:09 +0000] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [19/Jan/2014:15:17:09 +0000] [Client 16] No authentication data provided.
D [19/Jan/2014:15:17:09 +0000] [Client 16] 2.0 CUPS-Add-Modify-Printer 2
D [19/Jan/2014:15:17:09 +0000] CUPS-Add-Modify-Printer ipp://localhost:631/printers/test
D [19/Jan/2014:15:17:09 +0000] cupsdIsAuthorized: username=""
D [19/Jan/2014:15:17:09 +0000] [Client 16] Returning HTTP Unauthorized for CUPS-Add-Modify-Printer (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:17:09 +0000] [Client 16] WWW-Authenticate: Basic realm="CUPS", trc="y"
D [19/Jan/2014:15:17:09 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:17:09 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:17:09 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [19/Jan/2014:15:17:09 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:17:09 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:17:09 +0000] [Client 18] Accepted from localhost (Domain)
D [19/Jan/2014:15:17:09 +0000] [Client 18] Waiting for request.
D [19/Jan/2014:15:17:09 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:17:09 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:17:09 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [19/Jan/2014:15:17:09 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:17:09 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:17:09 +0000] [Client 18] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:17:09 +0000] [Client 18] Closing connection.
D [19/Jan/2014:15:17:09 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [19/Jan/2014:15:17:09 +0000] [Client 16] POST /admin/ HTTP/1.1
D [19/Jan/2014:15:17:09 +0000] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [19/Jan/2014:15:17:09 +0000] [Client 16] Authorized as root using PeerCred
D [19/Jan/2014:15:17:09 +0000] [Client 16] 2.0 CUPS-Add-Modify-Printer 2
D [19/Jan/2014:15:17:09 +0000] CUPS-Add-Modify-Printer ipp://localhost:631/printers/test
D [19/Jan/2014:15:17:09 +0000] cupsdIsAuthorized: username="root"
D [19/Jan/2014:15:17:09 +0000] test device-uri: OK
I [19/Jan/2014:15:17:09 +0000] Setting test device-uri to "file:/dev/null" (was "file:///dev/null".)
D [19/Jan/2014:15:17:09 +0000] copy_model: Running "cups-driverd cat drv:///hpijs.drv/hp-deskjet_f300_series-hpijs.ppd"...
D [19/Jan/2014:15:17:10 +0000] Copied PPD file successfully
D [19/Jan/2014:15:17:10 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:17:10 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [19/Jan/2014:15:17:10 +0000] Calling FindDeviceById(cups-test)
D [19/Jan/2014:15:17:10 +0000] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:10 +0000] Using profile ID "test-Gray..".
D [19/Jan/2014:15:17:10 +0000] Calling CreateProfile(test-Gray..,temp)
W [19/Jan/2014:15:17:10 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:10 +0000] Using profile ID "test-RGB..".
D [19/Jan/2014:15:17:10 +0000] Calling CreateProfile(test-RGB..,temp)
W [19/Jan/2014:15:17:10 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Jan/2014:15:17:10 +0000] Registering ICC color profiles for "test".
D [19/Jan/2014:15:17:10 +0000] Calling CreateDevice(cups-test,temp)
W [19/Jan/2014:15:17:10 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:10 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:17:10 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:17:10 +0000] load_ppd: Loading /etc/cups/ppd/test.ppd...
D [19/Jan/2014:15:17:10 +0000] load_ppd: Saving /var/cache/cups/test.data...
D [19/Jan/2014:15:17:10 +0000] cupsdRegisterPrinter(p=0xb86b7010(test))
D [19/Jan/2014:15:17:10 +0000] Registering "test @ desktop3" with DNS-SD type "_printer._tcp".
D [19/Jan/2014:15:17:10 +0000] Registering "test @ desktop3" with DNS-SD type "_ipps._tcp".
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" printer-type=0x80900E
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" printer-state=5
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" Color=T
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" TLS=1.2
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" UUID=afb48dc6-f981-3e92-58f7-f358efae06f6
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" URF=DM3
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" product=(HP Deskjet f394 All-in-one Printer)
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" priority=0
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" adminurl=https://desktop3.local:631/printers/test
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" ty=HP Deskjet f300 Series hpijs, 3.14.1
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" rp=printers/test
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" qtotal=1
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" txtvers=1
D [19/Jan/2014:15:17:10 +0000] Registering "test @ desktop3" with DNS-SD type "_ipp._tcp".
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" printer-type=0x80900E
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" printer-state=5
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" Color=T
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" TLS=1.2
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" UUID=afb48dc6-f981-3e92-58f7-f358efae06f6
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" URF=DM3
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" product=(HP Deskjet f394 All-in-one Printer)
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" priority=0
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" adminurl=https://desktop3.local:631/printers/test
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" ty=HP Deskjet f300 Series hpijs, 3.14.1
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" rp=printers/test
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" qtotal=1
D [19/Jan/2014:15:17:10 +0000] DNS_SD "test @ desktop3" txtvers=1
D [19/Jan/2014:15:17:10 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:17:10 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:17:10 +0000] cupsdMarkDirty(--p--)
D [19/Jan/2014:15:17:10 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:17:10 +0000] Discarding unused printer-added event...
I [19/Jan/2014:15:17:10 +0000] New printer "test" added by "root".
D [19/Jan/2014:15:17:10 +0000] [Client 16] Returning IPP successful-ok for CUPS-Add-Modify-Printer (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:17:10 +0000] [Client 16] Content-Length: 75
D [19/Jan/2014:15:17:10 +0000] PID 6678 (/usr/lib/cups/daemon/cups-driverd) exited with no errors.
D [19/Jan/2014:15:17:10 +0000] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0xb86aa0d0(IPP_IDLE), pipe_pid=0, file=-1
D [19/Jan/2014:15:17:10 +0000] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Jan/2014:15:17:10 +0000] [Client 16] bytes=0, http_state=0, data_remaining=0
D [19/Jan/2014:15:17:10 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:17:10 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:17:10 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:17:10 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:17:10 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Jan/2014:15:17:10 +0000] [Client 17] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:17:10 +0000] [Client 17] Closing connection.
D [19/Jan/2014:15:17:10 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Jan/2014:15:17:34 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:17:34 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:17:34 +0000] [Client 16] POST / HTTP/1.1
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Jan/2014:15:17:34 +0000] [Client 16] No authentication data provided.
D [19/Jan/2014:15:17:34 +0000] [Client 16] 2.0 Get-Printer-Attributes 1
D [19/Jan/2014:15:17:34 +0000] Get-Printer-Attributes ipp://localhost:631/printers/test
D [19/Jan/2014:15:17:34 +0000] [Client 16] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:17:34 +0000] [Client 16] Content-Length: 97
D [19/Jan/2014:15:17:34 +0000] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=97, response=0xb864f458(IPP_IDLE), pipe_pid=0, file=-1
D [19/Jan/2014:15:17:34 +0000] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Jan/2014:15:17:34 +0000] [Client 16] bytes=0, http_state=0, data_remaining=0
D [19/Jan/2014:15:17:34 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:17:34 +0000] [Client 16] POST /admin/ HTTP/1.1
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Jan/2014:15:17:34 +0000] [Client 16] No authentication data provided.
D [19/Jan/2014:15:17:34 +0000] [Client 16] 2.0 CUPS-Add-Modify-Printer 2
D [19/Jan/2014:15:17:34 +0000] CUPS-Add-Modify-Printer ipp://localhost:631/printers/test
D [19/Jan/2014:15:17:34 +0000] cupsdIsAuthorized: username=""
D [19/Jan/2014:15:17:34 +0000] [Client 16] Returning HTTP Unauthorized for CUPS-Add-Modify-Printer (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:17:34 +0000] [Client 16] WWW-Authenticate: Basic realm="CUPS", trc="y"
D [19/Jan/2014:15:17:34 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:17:34 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:17:34 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:17:34 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:17:34 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:17:34 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Jan/2014:15:17:34 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:17:34 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:17:34 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:17:34 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Jan/2014:15:17:34 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:17:34 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:17:34 +0000] [Client 16] POST /admin/ HTTP/1.1
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Jan/2014:15:17:34 +0000] [Client 16] Authorized as root using PeerCred
D [19/Jan/2014:15:17:34 +0000] [Client 16] 2.0 CUPS-Add-Modify-Printer 2
D [19/Jan/2014:15:17:34 +0000] CUPS-Add-Modify-Printer ipp://localhost:631/printers/test
D [19/Jan/2014:15:17:34 +0000] cupsdIsAuthorized: username="root"
D [19/Jan/2014:15:17:34 +0000] test device-uri: OK
I [19/Jan/2014:15:17:34 +0000] Setting test device-uri to "file:/dev/null" (was "file:/dev/null".)
D [19/Jan/2014:15:17:34 +0000] copy_model: Running "cups-driverd cat drv:///hpcups.drv/hp-deskjet_f300_series.ppd"...
D [19/Jan/2014:15:17:34 +0000] Copied PPD file successfully
D [19/Jan/2014:15:17:34 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:17:34 +0000] Calling FindDeviceById(cups-test)
D [19/Jan/2014:15:17:34 +0000] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:34 +0000] Using profile ID "test-Gray..".
D [19/Jan/2014:15:17:34 +0000] Calling CreateProfile(test-Gray..,temp)
W [19/Jan/2014:15:17:34 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:34 +0000] Using profile ID "test-RGB..".
D [19/Jan/2014:15:17:34 +0000] Calling CreateProfile(test-RGB..,temp)
W [19/Jan/2014:15:17:34 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Jan/2014:15:17:34 +0000] Registering ICC color profiles for "test".
D [19/Jan/2014:15:17:34 +0000] Calling CreateDevice(cups-test,temp)
W [19/Jan/2014:15:17:34 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:17:34 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:17:34 +0000] load_ppd: Loading /etc/cups/ppd/test.ppd...
D [19/Jan/2014:15:17:34 +0000] load_ppd: Saving /var/cache/cups/test.data...
D [19/Jan/2014:15:17:34 +0000] cupsdRegisterPrinter(p=0xb86b7010(test))
D [19/Jan/2014:15:17:34 +0000] Registering "test @ desktop3" with DNS-SD type "_printer._tcp".
D [19/Jan/2014:15:17:34 +0000] Registering "test @ desktop3" with DNS-SD type "_ipps._tcp".
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" printer-type=0x80901E
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" printer-state=5
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" Duplex=T
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" Color=T
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" TLS=1.2
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" UUID=afb48dc6-f981-3e92-58f7-f358efae06f6
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" URF=DM3
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" product=(HP Deskjet f394 All-in-one Printer)
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" priority=0
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" adminurl=https://desktop3.local:631/printers/test
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" ty=HP Deskjet f300 Series, hpcups 3.14.1
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" rp=printers/test
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" qtotal=1
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" txtvers=1
D [19/Jan/2014:15:17:34 +0000] Registering "test @ desktop3" with DNS-SD type "_ipp._tcp".
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" printer-type=0x80901E
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" printer-state=5
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" Duplex=T
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" Color=T
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" TLS=1.2
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" UUID=afb48dc6-f981-3e92-58f7-f358efae06f6
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" URF=DM3
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" product=(HP Deskjet f394 All-in-one Printer)
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" priority=0
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" adminurl=https://desktop3.local:631/printers/test
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" ty=HP Deskjet f300 Series, hpcups 3.14.1
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" rp=printers/test
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" qtotal=1
D [19/Jan/2014:15:17:34 +0000] DNS_SD "test @ desktop3" txtvers=1
D [19/Jan/2014:15:17:34 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:17:34 +0000] cupsdMarkDirty(--p--)
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:17:34 +0000] Discarding unused printer-modified event...
I [19/Jan/2014:15:17:34 +0000] Printer "test" modified by "root".
D [19/Jan/2014:15:17:34 +0000] [Client 16] Returning IPP successful-ok for CUPS-Add-Modify-Printer (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:17:34 +0000] [Client 16] Content-Length: 75
D [19/Jan/2014:15:17:34 +0000] PID 6681 (/usr/lib/cups/daemon/cups-driverd) exited with no errors.
D [19/Jan/2014:15:17:34 +0000] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0xb86b46e0(IPP_IDLE), pipe_pid=0, file=-1
D [19/Jan/2014:15:17:34 +0000] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Jan/2014:15:17:34 +0000] [Client 16] bytes=0, http_state=0, data_remaining=0
D [19/Jan/2014:15:17:34 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:17:34 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:17:34 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:17:34 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [19/Jan/2014:15:17:41 +0000] Saving printers.conf...
I [19/Jan/2014:15:17:41 +0000] Generating printcap /var/run/cups/printcap...
D [19/Jan/2014:15:17:41 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [19/Jan/2014:15:18:00 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:18:00 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:00 +0000] [Client 16] POST / HTTP/1.1
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [19/Jan/2014:15:18:00 +0000] [Client 16] No authentication data provided.
D [19/Jan/2014:15:18:00 +0000] [Client 16] 2.0 Get-Printer-Attributes 1
D [19/Jan/2014:15:18:00 +0000] Get-Printer-Attributes ipp://localhost:631/printers/test
D [19/Jan/2014:15:18:00 +0000] [Client 16] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:18:00 +0000] [Client 16] Content-Length: 97
D [19/Jan/2014:15:18:00 +0000] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=97, response=0xb86b3ba8(IPP_IDLE), pipe_pid=0, file=-1
D [19/Jan/2014:15:18:00 +0000] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Jan/2014:15:18:00 +0000] [Client 16] bytes=0, http_state=0, data_remaining=0
D [19/Jan/2014:15:18:00 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [19/Jan/2014:15:18:00 +0000] [Client 16] POST /admin/ HTTP/1.1
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [19/Jan/2014:15:18:00 +0000] [Client 16] No authentication data provided.
D [19/Jan/2014:15:18:00 +0000] [Client 16] 2.0 CUPS-Add-Modify-Printer 2
D [19/Jan/2014:15:18:00 +0000] CUPS-Add-Modify-Printer ipp://localhost:631/printers/test
D [19/Jan/2014:15:18:00 +0000] cupsdIsAuthorized: username=""
D [19/Jan/2014:15:18:00 +0000] [Client 16] Returning HTTP Unauthorized for CUPS-Add-Modify-Printer (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:18:00 +0000] [Client 16] WWW-Authenticate: Basic realm="CUPS", trc="y"
D [19/Jan/2014:15:18:00 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:18:00 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [19/Jan/2014:15:18:00 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:18:00 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:00 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:18:00 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [19/Jan/2014:15:18:00 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:18:00 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:00 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:18:00 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [19/Jan/2014:15:18:00 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:18:00 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:00 +0000] [Client 16] POST /admin/ HTTP/1.1
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [19/Jan/2014:15:18:00 +0000] [Client 16] Authorized as root using PeerCred
D [19/Jan/2014:15:18:00 +0000] [Client 16] 2.0 CUPS-Add-Modify-Printer 2
D [19/Jan/2014:15:18:00 +0000] CUPS-Add-Modify-Printer ipp://localhost:631/printers/test
D [19/Jan/2014:15:18:00 +0000] cupsdIsAuthorized: username="root"
D [19/Jan/2014:15:18:00 +0000] test device-uri: OK
I [19/Jan/2014:15:18:00 +0000] Setting test device-uri to "file:/dev/null" (was "file:/dev/null".)
D [19/Jan/2014:15:18:00 +0000] Copied PPD file successfully
D [19/Jan/2014:15:18:00 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [19/Jan/2014:15:18:00 +0000] Calling FindDeviceById(cups-test)
D [19/Jan/2014:15:18:00 +0000] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:18:00 +0000] Using profile ID "test-Gray..".
D [19/Jan/2014:15:18:00 +0000] Calling CreateProfile(test-Gray..,temp)
W [19/Jan/2014:15:18:00 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:18:00 +0000] Using profile ID "test-RGB..".
D [19/Jan/2014:15:18:00 +0000] Calling CreateProfile(test-RGB..,temp)
W [19/Jan/2014:15:18:00 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Jan/2014:15:18:00 +0000] Registering ICC color profiles for "test".
D [19/Jan/2014:15:18:00 +0000] Calling CreateDevice(cups-test,temp)
W [19/Jan/2014:15:18:00 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:18:00 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:18:00 +0000] load_ppd: Loading /etc/cups/ppd/test.ppd...
D [19/Jan/2014:15:18:00 +0000] load_ppd: Saving /var/cache/cups/test.data...
D [19/Jan/2014:15:18:00 +0000] cupsdRegisterPrinter(p=0xb86b7010(test))
D [19/Jan/2014:15:18:00 +0000] Registering "test @ desktop3" with DNS-SD type "_printer._tcp".
D [19/Jan/2014:15:18:00 +0000] Registering "test @ desktop3" with DNS-SD type "_ipps._tcp".
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" printer-type=0x80901E
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" printer-state=5
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" Duplex=T
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" Color=T
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" TLS=1.2
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" UUID=afb48dc6-f981-3e92-58f7-f358efae06f6
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" URF=DM3
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" product=(HP Deskjet f394 All-in-one Printer)
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" priority=0
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" adminurl=https://desktop3.local:631/printers/test
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" ty=HP Deskjet f300 Series, hpcups 3.14.1
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" rp=printers/test
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" qtotal=1
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" txtvers=1
D [19/Jan/2014:15:18:00 +0000] Registering "test @ desktop3" with DNS-SD type "_ipp._tcp".
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" printer-type=0x80901E
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" printer-state=5
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" Duplex=T
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" Color=T
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" TLS=1.2
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" UUID=afb48dc6-f981-3e92-58f7-f358efae06f6
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" URF=DM3
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" product=(HP Deskjet f394 All-in-one Printer)
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" priority=0
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" adminurl=https://desktop3.local:631/printers/test
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" ty=HP Deskjet f300 Series, hpcups 3.14.1
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" rp=printers/test
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" qtotal=1
D [19/Jan/2014:15:18:00 +0000] DNS_SD "test @ desktop3" txtvers=1
D [19/Jan/2014:15:18:00 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:18:00 +0000] cupsdMarkDirty(--p--)
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:18:00 +0000] Discarding unused printer-modified event...
I [19/Jan/2014:15:18:00 +0000] Printer "test" modified by "root".
D [19/Jan/2014:15:18:00 +0000] [Client 16] Returning IPP successful-ok for CUPS-Add-Modify-Printer (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:18:00 +0000] [Client 16] Content-Length: 75
D [19/Jan/2014:15:18:00 +0000] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0xb86b3ba8(IPP_IDLE), pipe_pid=0, file=-1
D [19/Jan/2014:15:18:00 +0000] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Jan/2014:15:18:00 +0000] [Client 16] bytes=0, http_state=0, data_remaining=0
D [19/Jan/2014:15:18:00 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:18:00 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:18:00 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:18:00 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Jan/2014:15:18:02 +0000] Report: clients=0
D [19/Jan/2014:15:18:02 +0000] Report: jobs=3
D [19/Jan/2014:15:18:02 +0000] Report: jobs-active=0
D [19/Jan/2014:15:18:02 +0000] Report: printers=7
D [19/Jan/2014:15:18:02 +0000] Report: stringpool-string-count=25994
D [19/Jan/2014:15:18:02 +0000] Report: stringpool-alloc-bytes=25272
D [19/Jan/2014:15:18:02 +0000] Report: stringpool-total-bytes=485240
D [19/Jan/2014:15:18:15 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:18:15 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:15 +0000] [Client 16] POST / HTTP/1.1
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Jan/2014:15:18:15 +0000] [Client 16] No authentication data provided.
D [19/Jan/2014:15:18:15 +0000] [Client 16] 2.0 Get-Printer-Attributes 1
D [19/Jan/2014:15:18:15 +0000] Get-Printer-Attributes ipp://localhost:631/printers/test
D [19/Jan/2014:15:18:15 +0000] [Client 16] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:18:15 +0000] [Client 16] Content-Length: 97
D [19/Jan/2014:15:18:15 +0000] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=97, response=0xb86b3ba8(IPP_IDLE), pipe_pid=0, file=-1
D [19/Jan/2014:15:18:15 +0000] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Jan/2014:15:18:15 +0000] [Client 16] bytes=0, http_state=0, data_remaining=0
D [19/Jan/2014:15:18:15 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:18:15 +0000] [Client 16] POST /admin/ HTTP/1.1
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Jan/2014:15:18:15 +0000] [Client 16] No authentication data provided.
D [19/Jan/2014:15:18:15 +0000] [Client 16] 2.0 CUPS-Add-Modify-Printer 2
D [19/Jan/2014:15:18:15 +0000] CUPS-Add-Modify-Printer ipp://localhost:631/printers/test
D [19/Jan/2014:15:18:15 +0000] cupsdIsAuthorized: username=""
D [19/Jan/2014:15:18:15 +0000] [Client 16] Returning HTTP Unauthorized for CUPS-Add-Modify-Printer (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:18:15 +0000] [Client 16] WWW-Authenticate: Basic realm="CUPS", trc="y"
D [19/Jan/2014:15:18:15 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:18:15 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:18:15 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:18:15 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:15 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:18:15 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Jan/2014:15:18:15 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:18:15 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:15 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:18:15 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Jan/2014:15:18:15 +0000] [Client 16] Accepted from localhost (Domain)
D [19/Jan/2014:15:18:15 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:15 +0000] [Client 16] POST /admin/ HTTP/1.1
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Jan/2014:15:18:15 +0000] [Client 16] Authorized as root using PeerCred
D [19/Jan/2014:15:18:15 +0000] [Client 16] 2.0 CUPS-Add-Modify-Printer 2
D [19/Jan/2014:15:18:15 +0000] CUPS-Add-Modify-Printer ipp://localhost:631/printers/test
D [19/Jan/2014:15:18:15 +0000] cupsdIsAuthorized: username="root"
D [19/Jan/2014:15:18:15 +0000] test device-uri: OK
I [19/Jan/2014:15:18:15 +0000] Setting test device-uri to "file:/dev/null" (was "file:/dev/null".)
D [19/Jan/2014:15:18:15 +0000] copy_model: Running "cups-driverd cat drv:///hpijs.drv/hp-deskjet_f300_series-hpijs.ppd"...
D [19/Jan/2014:15:18:15 +0000] Copied PPD file successfully
D [19/Jan/2014:15:18:15 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:18:15 +0000] Calling FindDeviceById(cups-test)
D [19/Jan/2014:15:18:15 +0000] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:18:15 +0000] Using profile ID "test-Gray..".
D [19/Jan/2014:15:18:15 +0000] Calling CreateProfile(test-Gray..,temp)
W [19/Jan/2014:15:18:15 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:18:15 +0000] Using profile ID "test-RGB..".
D [19/Jan/2014:15:18:15 +0000] Calling CreateProfile(test-RGB..,temp)
W [19/Jan/2014:15:18:15 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Jan/2014:15:18:15 +0000] Registering ICC color profiles for "test".
D [19/Jan/2014:15:18:15 +0000] Calling CreateDevice(cups-test,temp)
W [19/Jan/2014:15:18:15 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Jan/2014:15:18:15 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:18:15 +0000] load_ppd: Loading /etc/cups/ppd/test.ppd...
D [19/Jan/2014:15:18:15 +0000] load_ppd: Saving /var/cache/cups/test.data...
D [19/Jan/2014:15:18:15 +0000] cupsdRegisterPrinter(p=0xb86b7010(test))
D [19/Jan/2014:15:18:15 +0000] Registering "test @ desktop3" with DNS-SD type "_printer._tcp".
D [19/Jan/2014:15:18:15 +0000] Registering "test @ desktop3" with DNS-SD type "_ipps._tcp".
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" printer-type=0x80900E
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" printer-state=5
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" Color=T
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" TLS=1.2
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" UUID=afb48dc6-f981-3e92-58f7-f358efae06f6
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" URF=DM3
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" product=(HP Deskjet f394 All-in-one Printer)
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" priority=0
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" adminurl=https://desktop3.local:631/printers/test
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" ty=HP Deskjet f300 Series hpijs, 3.14.1
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" rp=printers/test
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" qtotal=1
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" txtvers=1
D [19/Jan/2014:15:18:15 +0000] Registering "test @ desktop3" with DNS-SD type "_ipp._tcp".
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" printer-type=0x80900E
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" printer-state=5
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" Color=T
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" TLS=1.2
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" UUID=afb48dc6-f981-3e92-58f7-f358efae06f6
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" URF=DM3
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/urf
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" product=(HP Deskjet f394 All-in-one Printer)
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" priority=0
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" adminurl=https://desktop3.local:631/printers/test
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" ty=HP Deskjet f300 Series hpijs, 3.14.1
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" rp=printers/test
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" qtotal=1
D [19/Jan/2014:15:18:15 +0000] DNS_SD "test @ desktop3" txtvers=1
D [19/Jan/2014:15:18:15 +0000] cupsdMarkDirty(P----)
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:18:15 +0000] cupsdMarkDirty(--p--)
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:18:15 +0000] Discarding unused printer-modified event...
I [19/Jan/2014:15:18:15 +0000] Printer "test" modified by "root".
D [19/Jan/2014:15:18:15 +0000] [Client 16] Returning IPP successful-ok for CUPS-Add-Modify-Printer (ipp://localhost:631/printers/test) from localhost
D [19/Jan/2014:15:18:15 +0000] [Client 16] Content-Length: 75
D [19/Jan/2014:15:18:15 +0000] PID 6686 (/usr/lib/cups/daemon/cups-driverd) exited with no errors.
D [19/Jan/2014:15:18:15 +0000] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0xb86becb0(IPP_IDLE), pipe_pid=0, file=-1
D [19/Jan/2014:15:18:15 +0000] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Jan/2014:15:18:15 +0000] [Client 16] bytes=0, http_state=0, data_remaining=0
D [19/Jan/2014:15:18:15 +0000] [Client 16] Waiting for request.
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Jan/2014:15:18:15 +0000] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [19/Jan/2014:15:18:15 +0000] [Client 16] Closing connection.
D [19/Jan/2014:15:18:15 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [19/Jan/2014:15:18:31 +0000] Saving printers.conf...
I [19/Jan/2014:15:18:31 +0000] Generating printcap /var/run/cups/printcap...
D [19/Jan/2014:15:18:31 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"

--- End Message ---
--- Begin Message --- 
Version: 2.0.3-4

Closing then,

Cheers,
OdyX

--- End Message ---
Reply to: