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

Debian Bug Tracking System Tue, 07 Jul 2015 13:27:06 -0700

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 [email protected]
immediately.)


-- 
736089: http://bugs.debian.org/cgi-bin/bugreport.cgi?bug=736089
Debian Bug Tracking System
Contact [email protected] 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 ---

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

Reply via email to