I [23/Mar/2012:07:58:00 +0100] Remote access is disabled.
D [23/Mar/2012:07:58:00 +0100] Added auto ServerAlias ubuntu
I [23/Mar/2012:07:58:00 +0100] Loaded configuration file "/etc/cups/cupsd.conf"
I [23/Mar/2012:07:58:00 +0100] Using default TempDir of /var/spool/cups/tmp...
I [23/Mar/2012:07:58:00 +0100] Configured for up to 100 clients.
I [23/Mar/2012:07:58:00 +0100] Allowing up to 100 client connections per host.
I [23/Mar/2012:07:58:00 +0100] Using policy "default" as the default.
I [23/Mar/2012:07:58:00 +0100] Full reload is required.
I [23/Mar/2012:07:58:00 +0100] Saving job.cache...
D [23/Mar/2012:07:58:01 +0100] Discarding unused printer-stopped event...
D [23/Mar/2012:07:58:01 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:07:58:01 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Not busy"
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-Canon)
D [23/Mar/2012:07:58:01 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:01 +0100] cupsdDeregisterPrinter(p=0x214d1e50(Canon), removeit=1)
D [23/Mar/2012:07:58:01 +0100] Discarding unused printer-stopped event...
D [23/Mar/2012:07:58:01 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:07:58:01 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-Iwona)
D [23/Mar/2012:07:58:01 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:01 +0100] cupsdDeregisterPrinter(p=0x21503c58(Iwona), removeit=1)
D [23/Mar/2012:07:58:01 +0100] Discarding unused printer-stopped event...
D [23/Mar/2012:07:58:01 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:07:58:01 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-ksiegowosc)
D [23/Mar/2012:07:58:01 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:01 +0100] cupsdDeregisterPrinter(p=0x215d2f20(ksiegowosc), removeit=1)
D [23/Mar/2012:07:58:01 +0100] Discarding unused printer-stopped event...
D [23/Mar/2012:07:58:01 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:07:58:01 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-lj1150)
D [23/Mar/2012:07:58:01 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:01 +0100] cupsdDeregisterPrinter(p=0x215df4e0(lj1150), removeit=1)
D [23/Mar/2012:07:58:01 +0100] Discarding unused printer-stopped event...
D [23/Mar/2012:07:58:01 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:07:58:01 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-PDF)
D [23/Mar/2012:07:58:01 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:01 +0100] cupsdDeregisterPrinter(p=0x215e2d70(PDF), removeit=1)
D [23/Mar/2012:07:58:01 +0100] Discarding unused printer-stopped event...
D [23/Mar/2012:07:58:01 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:07:58:01 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-pietro)
D [23/Mar/2012:07:58:01 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:01 +0100] cupsdDeregisterPrinter(p=0x215f6ad8(pietro), removeit=1)
D [23/Mar/2012:07:58:01 +0100] Discarding unused printer-stopped event...
D [23/Mar/2012:07:58:01 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:07:58:01 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-zakupy)
D [23/Mar/2012:07:58:01 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:01 +0100] cupsdDeregisterPrinter(p=0x21611cc0(zakupy), removeit=1)
E [23/Mar/2012:07:58:01 +0100] Filter "hpgltops" not found.
E [23/Mar/2012:07:58:01 +0100] Filter "pstoraster" not found.
E [23/Mar/2012:07:58:01 +0100] Filter "pstoraster" not found.
I [23/Mar/2012:07:58:01 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 40 types, 78 filters...
D [23/Mar/2012:07:58:01 +0100] Loading printer Canon...
D [23/Mar/2012:07:58:01 +0100] load_ppd: Loading /var/cache/cups/Canon.data...
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-Canon)
D [23/Mar/2012:07:58:01 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:01 +0100] Using profile id of Canon-Gray..
D [23/Mar/2012:07:58:01 +0100] Calling CreateProfile(Canon-Gray..,temp)
D [23/Mar/2012:07:58:01 +0100] created profile /org/freedesktop/ColorManager/profiles/Canon_Gray__
I [23/Mar/2012:07:58:01 +0100] Registering ICC color profiles for "Canon"
D [23/Mar/2012:07:58:01 +0100] Calling CreateDevice(cups-Canon,temp)
D [23/Mar/2012:07:58:01 +0100] created device /org/freedesktop/ColorManager/devices/cups_Canon
D [23/Mar/2012:07:58:01 +0100] Calling /org/freedesktop/ColorManager/devices/cups_Canon:AddProfile(/org/freedesktop/ColorManager/profiles/Canon_Gray__) [soft]
W [23/Mar/2012:07:58:01 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/Canon_Gray__' has already been added
D [23/Mar/2012:07:58:01 +0100] cupsdRegisterPrinter(p=0x215323c0(Canon))
D [23/Mar/2012:07:58:01 +0100] load_ppd: Loading /var/cache/cups/Canon.data...
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-Canon)
D [23/Mar/2012:07:58:01 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:01 +0100] Using profile id of Canon-Gray..
D [23/Mar/2012:07:58:01 +0100] Calling CreateProfile(Canon-Gray..,temp)
D [23/Mar/2012:07:58:01 +0100] created profile /org/freedesktop/ColorManager/profiles/Canon_Gray__
I [23/Mar/2012:07:58:01 +0100] Registering ICC color profiles for "Canon"
D [23/Mar/2012:07:58:01 +0100] Calling CreateDevice(cups-Canon,temp)
D [23/Mar/2012:07:58:01 +0100] created device /org/freedesktop/ColorManager/devices/cups_Canon
D [23/Mar/2012:07:58:01 +0100] Calling /org/freedesktop/ColorManager/devices/cups_Canon:AddProfile(/org/freedesktop/ColorManager/profiles/Canon_Gray__) [soft]
W [23/Mar/2012:07:58:01 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/Canon_Gray__' has already been added
D [23/Mar/2012:07:58:01 +0100] cupsdRegisterPrinter(p=0x215323c0(Canon))
D [23/Mar/2012:07:58:01 +0100] Loading printer Iwona...
D [23/Mar/2012:07:58:01 +0100] load_ppd: Loading /var/cache/cups/Iwona.data...
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-Iwona)
D [23/Mar/2012:07:58:01 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:01 +0100] Using profile id of Iwona-Gray..
D [23/Mar/2012:07:58:01 +0100] Calling CreateProfile(Iwona-Gray..,temp)
D [23/Mar/2012:07:58:01 +0100] created profile /org/freedesktop/ColorManager/profiles/Iwona_Gray__
I [23/Mar/2012:07:58:01 +0100] Registering ICC color profiles for "Iwona"
D [23/Mar/2012:07:58:01 +0100] Calling CreateDevice(cups-Iwona,temp)
D [23/Mar/2012:07:58:01 +0100] created device /org/freedesktop/ColorManager/devices/cups_Iwona
D [23/Mar/2012:07:58:01 +0100] Calling /org/freedesktop/ColorManager/devices/cups_Iwona:AddProfile(/org/freedesktop/ColorManager/profiles/Iwona_Gray__) [soft]
W [23/Mar/2012:07:58:01 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/Iwona_Gray__' has already been added
D [23/Mar/2012:07:58:01 +0100] cupsdRegisterPrinter(p=0x214daae8(Iwona))
D [23/Mar/2012:07:58:01 +0100] load_ppd: Loading /var/cache/cups/Iwona.data...
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-Iwona)
D [23/Mar/2012:07:58:01 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:01 +0100] Using profile id of Iwona-Gray..
D [23/Mar/2012:07:58:01 +0100] Calling CreateProfile(Iwona-Gray..,temp)
D [23/Mar/2012:07:58:01 +0100] created profile /org/freedesktop/ColorManager/profiles/Iwona_Gray__
I [23/Mar/2012:07:58:01 +0100] Registering ICC color profiles for "Iwona"
D [23/Mar/2012:07:58:01 +0100] Calling CreateDevice(cups-Iwona,temp)
D [23/Mar/2012:07:58:01 +0100] created device /org/freedesktop/ColorManager/devices/cups_Iwona
D [23/Mar/2012:07:58:01 +0100] Calling /org/freedesktop/ColorManager/devices/cups_Iwona:AddProfile(/org/freedesktop/ColorManager/profiles/Iwona_Gray__) [soft]
W [23/Mar/2012:07:58:01 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/Iwona_Gray__' has already been added
D [23/Mar/2012:07:58:01 +0100] cupsdRegisterPrinter(p=0x214daae8(Iwona))
D [23/Mar/2012:07:58:01 +0100] Loading printer ksiegowosc...
D [23/Mar/2012:07:58:01 +0100] load_ppd: Loading /var/cache/cups/ksiegowosc.data...
D [23/Mar/2012:07:58:01 +0100] Calling DeleteDevice(cups-ksiegowosc)
D [23/Mar/2012:07:58:02 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:02 +0100] Using profile id of ksiegowosc-Gray..
D [23/Mar/2012:07:58:02 +0100] Calling CreateProfile(ksiegowosc-Gray..,temp)
D [23/Mar/2012:07:58:02 +0100] created profile /org/freedesktop/ColorManager/profiles/ksiegowosc_Gray__
D [23/Mar/2012:07:58:02 +0100] Using profile id of ksiegowosc-RGB..
D [23/Mar/2012:07:58:02 +0100] Calling CreateProfile(ksiegowosc-RGB..,temp)
D [23/Mar/2012:07:58:02 +0100] created profile /org/freedesktop/ColorManager/profiles/ksiegowosc_RGB__
I [23/Mar/2012:07:58:02 +0100] Registering ICC color profiles for "ksiegowosc"
D [23/Mar/2012:07:58:02 +0100] Calling CreateDevice(cups-ksiegowosc,temp)
D [23/Mar/2012:07:58:02 +0100] created device /org/freedesktop/ColorManager/devices/cups_ksiegowosc
D [23/Mar/2012:07:58:02 +0100] Calling /org/freedesktop/ColorManager/devices/cups_ksiegowosc:AddProfile(/org/freedesktop/ColorManager/profiles/ksiegowosc_Gray__) [soft]
W [23/Mar/2012:07:58:02 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/ksiegowosc_Gray__' has already been added
D [23/Mar/2012:07:58:02 +0100] Calling /org/freedesktop/ColorManager/devices/cups_ksiegowosc:AddProfile(/org/freedesktop/ColorManager/profiles/ksiegowosc_RGB__) [soft]
W [23/Mar/2012:07:58:02 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/ksiegowosc_RGB__' has already been added
D [23/Mar/2012:07:58:02 +0100] cupsdRegisterPrinter(p=0x21650438(ksiegowosc))
D [23/Mar/2012:07:58:02 +0100] load_ppd: Loading /var/cache/cups/ksiegowosc.data...
D [23/Mar/2012:07:58:02 +0100] Calling DeleteDevice(cups-ksiegowosc)
D [23/Mar/2012:07:58:02 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:02 +0100] Using profile id of ksiegowosc-Gray..
D [23/Mar/2012:07:58:02 +0100] Calling CreateProfile(ksiegowosc-Gray..,temp)
D [23/Mar/2012:07:58:02 +0100] created profile /org/freedesktop/ColorManager/profiles/ksiegowosc_Gray__
D [23/Mar/2012:07:58:02 +0100] Using profile id of ksiegowosc-RGB..
D [23/Mar/2012:07:58:02 +0100] Calling CreateProfile(ksiegowosc-RGB..,temp)
D [23/Mar/2012:07:58:02 +0100] created profile /org/freedesktop/ColorManager/profiles/ksiegowosc_RGB__
I [23/Mar/2012:07:58:02 +0100] Registering ICC color profiles for "ksiegowosc"
D [23/Mar/2012:07:58:02 +0100] Calling CreateDevice(cups-ksiegowosc,temp)
D [23/Mar/2012:07:58:02 +0100] created device /org/freedesktop/ColorManager/devices/cups_ksiegowosc
D [23/Mar/2012:07:58:02 +0100] Calling /org/freedesktop/ColorManager/devices/cups_ksiegowosc:AddProfile(/org/freedesktop/ColorManager/profiles/ksiegowosc_Gray__) [soft]
W [23/Mar/2012:07:58:02 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/ksiegowosc_Gray__' has already been added
D [23/Mar/2012:07:58:02 +0100] Calling /org/freedesktop/ColorManager/devices/cups_ksiegowosc:AddProfile(/org/freedesktop/ColorManager/profiles/ksiegowosc_RGB__) [soft]
W [23/Mar/2012:07:58:02 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/ksiegowosc_RGB__' has already been added
D [23/Mar/2012:07:58:02 +0100] cupsdRegisterPrinter(p=0x21650438(ksiegowosc))
D [23/Mar/2012:07:58:02 +0100] Loading printer lj1150...
D [23/Mar/2012:07:58:02 +0100] load_ppd: Loading /var/cache/cups/lj1150.data...
D [23/Mar/2012:07:58:02 +0100] Calling DeleteDevice(cups-lj1150)
D [23/Mar/2012:07:58:02 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:02 +0100] Using profile id of lj1150-Gray..
D [23/Mar/2012:07:58:02 +0100] Calling CreateProfile(lj1150-Gray..,temp)
D [23/Mar/2012:07:58:02 +0100] created profile /org/freedesktop/ColorManager/profiles/lj1150_Gray__
D [23/Mar/2012:07:58:02 +0100] Using profile id of lj1150-RGB..
D [23/Mar/2012:07:58:02 +0100] Calling CreateProfile(lj1150-RGB..,temp)
D [23/Mar/2012:07:58:02 +0100] created profile /org/freedesktop/ColorManager/profiles/lj1150_RGB__
I [23/Mar/2012:07:58:02 +0100] Registering ICC color profiles for "lj1150"
D [23/Mar/2012:07:58:02 +0100] Calling CreateDevice(cups-lj1150,temp)
D [23/Mar/2012:07:58:02 +0100] created device /org/freedesktop/ColorManager/devices/cups_lj1150
D [23/Mar/2012:07:58:02 +0100] Calling /org/freedesktop/ColorManager/devices/cups_lj1150:AddProfile(/org/freedesktop/ColorManager/profiles/lj1150_Gray__) [soft]
W [23/Mar/2012:07:58:02 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/lj1150_Gray__' has already been added
D [23/Mar/2012:07:58:02 +0100] Calling /org/freedesktop/ColorManager/devices/cups_lj1150:AddProfile(/org/freedesktop/ColorManager/profiles/lj1150_RGB__) [soft]
W [23/Mar/2012:07:58:02 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/lj1150_RGB__' has already been added
D [23/Mar/2012:07:58:02 +0100] cupsdRegisterPrinter(p=0x21551b58(lj1150))
D [23/Mar/2012:07:58:02 +0100] Loading printer PDF...
D [23/Mar/2012:07:58:02 +0100] load_ppd: Loading /var/cache/cups/PDF.data...
D [23/Mar/2012:07:58:02 +0100] Calling DeleteDevice(cups-PDF)
D [23/Mar/2012:07:58:02 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:02 +0100] Using profile id of PDF-Gray..
D [23/Mar/2012:07:58:02 +0100] Calling CreateProfile(PDF-Gray..,temp)
D [23/Mar/2012:07:58:02 +0100] created profile /org/freedesktop/ColorManager/profiles/PDF_Gray__
D [23/Mar/2012:07:58:02 +0100] Using profile id of PDF-RGB..
D [23/Mar/2012:07:58:02 +0100] Calling CreateProfile(PDF-RGB..,temp)
D [23/Mar/2012:07:58:02 +0100] created profile /org/freedesktop/ColorManager/profiles/PDF_RGB__
I [23/Mar/2012:07:58:02 +0100] Registering ICC color profiles for "PDF"
D [23/Mar/2012:07:58:02 +0100] Calling CreateDevice(cups-PDF,temp)
D [23/Mar/2012:07:58:02 +0100] created device /org/freedesktop/ColorManager/devices/cups_PDF
D [23/Mar/2012:07:58:02 +0100] Calling /org/freedesktop/ColorManager/devices/cups_PDF:AddProfile(/org/freedesktop/ColorManager/profiles/PDF_Gray__) [soft]
W [23/Mar/2012:07:58:02 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/PDF_Gray__' has already been added
D [23/Mar/2012:07:58:02 +0100] Calling /org/freedesktop/ColorManager/devices/cups_PDF:AddProfile(/org/freedesktop/ColorManager/profiles/PDF_RGB__) [soft]
W [23/Mar/2012:07:58:02 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/PDF_RGB__' has already been added
D [23/Mar/2012:07:58:02 +0100] cupsdRegisterPrinter(p=0x216b4ba8(PDF))
D [23/Mar/2012:07:58:02 +0100] Loading printer pietro...
D [23/Mar/2012:07:58:02 +0100] load_ppd: Loading /var/cache/cups/pietro.data...
D [23/Mar/2012:07:58:02 +0100] Calling DeleteDevice(cups-pietro)
D [23/Mar/2012:07:58:02 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:02 +0100] Using profile id of pietro-Gray..
D [23/Mar/2012:07:58:02 +0100] Calling CreateProfile(pietro-Gray..,temp)
D [23/Mar/2012:07:58:02 +0100] created profile /org/freedesktop/ColorManager/profiles/pietro_Gray__
D [23/Mar/2012:07:58:02 +0100] Using profile id of pietro-RGB..
D [23/Mar/2012:07:58:02 +0100] Calling CreateProfile(pietro-RGB..,temp)
D [23/Mar/2012:07:58:02 +0100] created profile /org/freedesktop/ColorManager/profiles/pietro_RGB__
I [23/Mar/2012:07:58:02 +0100] Registering ICC color profiles for "pietro"
D [23/Mar/2012:07:58:02 +0100] Calling CreateDevice(cups-pietro,temp)
D [23/Mar/2012:07:58:02 +0100] created device /org/freedesktop/ColorManager/devices/cups_pietro
D [23/Mar/2012:07:58:02 +0100] Calling /org/freedesktop/ColorManager/devices/cups_pietro:AddProfile(/org/freedesktop/ColorManager/profiles/pietro_Gray__) [soft]
W [23/Mar/2012:07:58:02 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/pietro_Gray__' has already been added
D [23/Mar/2012:07:58:02 +0100] Calling /org/freedesktop/ColorManager/devices/cups_pietro:AddProfile(/org/freedesktop/ColorManager/profiles/pietro_RGB__) [soft]
W [23/Mar/2012:07:58:02 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/pietro_RGB__' has already been added
D [23/Mar/2012:07:58:02 +0100] cupsdRegisterPrinter(p=0x2166d138(pietro))
D [23/Mar/2012:07:58:02 +0100] Loading printer zakupy...
D [23/Mar/2012:07:58:02 +0100] load_ppd: Loading /var/cache/cups/zakupy.data...
D [23/Mar/2012:07:58:02 +0100] Calling DeleteDevice(cups-zakupy)
D [23/Mar/2012:07:58:02 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:07:58:02 +0100] Using profile id of zakupy-Gray..
D [23/Mar/2012:07:58:02 +0100] Calling CreateProfile(zakupy-Gray..,temp)
D [23/Mar/2012:07:58:02 +0100] created profile /org/freedesktop/ColorManager/profiles/zakupy_Gray__
I [23/Mar/2012:07:58:02 +0100] Registering ICC color profiles for "zakupy"
D [23/Mar/2012:07:58:02 +0100] Calling CreateDevice(cups-zakupy,temp)
D [23/Mar/2012:07:58:02 +0100] created device /org/freedesktop/ColorManager/devices/cups_zakupy
D [23/Mar/2012:07:58:02 +0100] Calling /org/freedesktop/ColorManager/devices/cups_zakupy:AddProfile(/org/freedesktop/ColorManager/profiles/zakupy_Gray__) [soft]
W [23/Mar/2012:07:58:02 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/zakupy_Gray__' has already been added
D [23/Mar/2012:07:58:02 +0100] cupsdRegisterPrinter(p=0x216cc700(zakupy))
D [23/Mar/2012:07:58:02 +0100] cupsdLoadRemoteCache: Not loading remote cache.
I [23/Mar/2012:07:58:02 +0100] Loading job cache file "/var/cache/cups/job.cache"...
D [23/Mar/2012:07:58:02 +0100] [Job 63] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 64] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 65] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 66] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 67] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 68] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 69] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 70] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 71] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 72] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 73] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 74] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 75] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 76] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 77] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 78] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 79] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 80] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 81] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 82] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 83] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 84] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 85] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 86] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 87] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 88] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 89] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 90] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 91] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 92] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 93] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 94] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 95] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 96] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 97] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 98] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 99] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 100] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 101] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] [Job 102] Loading from cache...
D [23/Mar/2012:07:58:02 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [23/Mar/2012:07:58:02 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [23/Mar/2012:07:58:02 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
I [23/Mar/2012:07:58:02 +0100] Full reload complete.
I [23/Mar/2012:07:58:02 +0100] Listening to [v1.::1]:631 on fd 9...
I [23/Mar/2012:07:58:02 +0100] Listening to 127.0.0.1:631 on fd 10...
I [23/Mar/2012:07:58:02 +0100] Listening to /var/run/cups/cups.sock:631 on fd 11...
I [23/Mar/2012:07:58:02 +0100] Resuming new connection processing...
D [23/Mar/2012:07:58:02 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:07:58:02 +0100] Discarding unused server-restarted event...
I [23/Mar/2012:07:58:32 +0100] Saving printers.conf...
D [23/Mar/2012:07:58:33 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [23/Mar/2012:08:02:16 +0100] Report: clients=0
D [23/Mar/2012:08:02:16 +0100] Report: jobs=40
D [23/Mar/2012:08:02:16 +0100] Report: jobs-active=0
D [23/Mar/2012:08:02:16 +0100] Report: printers=7
D [23/Mar/2012:08:02:16 +0100] Report: printers-implicit=0
D [23/Mar/2012:08:02:16 +0100] Report: stringpool-string-count=45855
D [23/Mar/2012:08:02:16 +0100] Report: stringpool-alloc-bytes=16504
D [23/Mar/2012:08:02:16 +0100] Report: stringpool-total-bytes=844376
D [23/Mar/2012:08:06:29 +0100] Report: clients=0
D [23/Mar/2012:08:06:30 +0100] Report: jobs=40
D [23/Mar/2012:08:06:30 +0100] Report: jobs-active=0
D [23/Mar/2012:08:06:30 +0100] Report: printers=7
D [23/Mar/2012:08:06:30 +0100] Report: printers-implicit=0
D [23/Mar/2012:08:06:30 +0100] Report: stringpool-string-count=45855
D [23/Mar/2012:08:06:30 +0100] Report: stringpool-alloc-bytes=16504
D [23/Mar/2012:08:06:30 +0100] Report: stringpool-total-bytes=844376
I [23/Mar/2012:08:08:24 +0100] Scheduler shutting down normally.
D [23/Mar/2012:08:08:24 +0100] Discarding unused server-stopped event...
I [23/Mar/2012:08:08:24 +0100] Saving job.cache...
I [23/Mar/2012:08:08:26 +0100] Listening to [v1.::1]:631 (IPv6)
I [23/Mar/2012:08:08:26 +0100] Listening to 127.0.0.1:631 (IPv4)
I [23/Mar/2012:08:08:26 +0100] Listening to /var/run/cups/cups.sock (Domain)
I [23/Mar/2012:08:08:26 +0100] Remote access is disabled.
D [23/Mar/2012:08:08:26 +0100] Added auto ServerAlias ubuntu
I [23/Mar/2012:08:08:26 +0100] Loaded configuration file "/etc/cups/cupsd.conf"
I [23/Mar/2012:08:08:26 +0100] Using default TempDir of /var/spool/cups/tmp...
I [23/Mar/2012:08:08:26 +0100] Configured for up to 100 clients.
I [23/Mar/2012:08:08:26 +0100] Allowing up to 100 client connections per host.
I [23/Mar/2012:08:08:26 +0100] Using policy "default" as the default.
I [23/Mar/2012:08:08:26 +0100] Full reload is required.
E [23/Mar/2012:08:08:26 +0100] Filter "hpgltops" not found.
E [23/Mar/2012:08:08:26 +0100] Filter "pstoraster" not found.
E [23/Mar/2012:08:08:26 +0100] Filter "pstoraster" not found.
I [23/Mar/2012:08:08:26 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 40 types, 78 filters...
D [23/Mar/2012:08:08:26 +0100] Loading printer Canon...
D [23/Mar/2012:08:08:26 +0100] load_ppd: Loading /var/cache/cups/Canon.data...
D [23/Mar/2012:08:08:26 +0100] Calling DeleteDevice(cups-Canon)
D [23/Mar/2012:08:08:26 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:08:08:26 +0100] Using profile id of Canon-Gray..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(Canon-Gray..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/Canon_Gray__
I [23/Mar/2012:08:08:26 +0100] Registering ICC color profiles for "Canon"
D [23/Mar/2012:08:08:26 +0100] Calling CreateDevice(cups-Canon,temp)
D [23/Mar/2012:08:08:26 +0100] created device /org/freedesktop/ColorManager/devices/cups_Canon
D [23/Mar/2012:08:08:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_Canon:AddProfile(/org/freedesktop/ColorManager/profiles/Canon_Gray__) [soft]
D [23/Mar/2012:08:08:26 +0100] cupsdRegisterPrinter(p=0x203d6f30(Canon))
D [23/Mar/2012:08:08:26 +0100] load_ppd: Loading /var/cache/cups/Canon.data...
D [23/Mar/2012:08:08:26 +0100] Calling DeleteDevice(cups-Canon)
D [23/Mar/2012:08:08:26 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:08:08:26 +0100] Using profile id of Canon-Gray..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(Canon-Gray..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/Canon_Gray__
I [23/Mar/2012:08:08:26 +0100] Registering ICC color profiles for "Canon"
D [23/Mar/2012:08:08:26 +0100] Calling CreateDevice(cups-Canon,temp)
D [23/Mar/2012:08:08:26 +0100] created device /org/freedesktop/ColorManager/devices/cups_Canon
D [23/Mar/2012:08:08:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_Canon:AddProfile(/org/freedesktop/ColorManager/profiles/Canon_Gray__) [soft]
W [23/Mar/2012:08:08:26 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/Canon_Gray__' has already been added
D [23/Mar/2012:08:08:26 +0100] cupsdRegisterPrinter(p=0x203d6f30(Canon))
D [23/Mar/2012:08:08:26 +0100] Loading printer Iwona...
D [23/Mar/2012:08:08:26 +0100] load_ppd: Loading /var/cache/cups/Iwona.data...
D [23/Mar/2012:08:08:26 +0100] Calling DeleteDevice(cups-Iwona)
D [23/Mar/2012:08:08:26 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:08:08:26 +0100] Using profile id of Iwona-Gray..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(Iwona-Gray..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/Iwona_Gray__
I [23/Mar/2012:08:08:26 +0100] Registering ICC color profiles for "Iwona"
D [23/Mar/2012:08:08:26 +0100] Calling CreateDevice(cups-Iwona,temp)
D [23/Mar/2012:08:08:26 +0100] created device /org/freedesktop/ColorManager/devices/cups_Iwona
D [23/Mar/2012:08:08:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_Iwona:AddProfile(/org/freedesktop/ColorManager/profiles/Iwona_Gray__) [soft]
D [23/Mar/2012:08:08:26 +0100] cupsdRegisterPrinter(p=0x2048fa20(Iwona))
D [23/Mar/2012:08:08:26 +0100] load_ppd: Loading /var/cache/cups/Iwona.data...
D [23/Mar/2012:08:08:26 +0100] Calling DeleteDevice(cups-Iwona)
D [23/Mar/2012:08:08:26 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:08:08:26 +0100] Using profile id of Iwona-Gray..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(Iwona-Gray..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/Iwona_Gray__
I [23/Mar/2012:08:08:26 +0100] Registering ICC color profiles for "Iwona"
D [23/Mar/2012:08:08:26 +0100] Calling CreateDevice(cups-Iwona,temp)
D [23/Mar/2012:08:08:26 +0100] created device /org/freedesktop/ColorManager/devices/cups_Iwona
D [23/Mar/2012:08:08:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_Iwona:AddProfile(/org/freedesktop/ColorManager/profiles/Iwona_Gray__) [soft]
W [23/Mar/2012:08:08:26 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/Iwona_Gray__' has already been added
D [23/Mar/2012:08:08:26 +0100] cupsdRegisterPrinter(p=0x2048fa20(Iwona))
D [23/Mar/2012:08:08:26 +0100] Loading printer ksiegowosc...
D [23/Mar/2012:08:08:26 +0100] load_ppd: Loading /var/cache/cups/ksiegowosc.data...
D [23/Mar/2012:08:08:26 +0100] Calling DeleteDevice(cups-ksiegowosc)
D [23/Mar/2012:08:08:26 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:08:08:26 +0100] Using profile id of ksiegowosc-Gray..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(ksiegowosc-Gray..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/ksiegowosc_Gray__
D [23/Mar/2012:08:08:26 +0100] Using profile id of ksiegowosc-RGB..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(ksiegowosc-RGB..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/ksiegowosc_RGB__
I [23/Mar/2012:08:08:26 +0100] Registering ICC color profiles for "ksiegowosc"
D [23/Mar/2012:08:08:26 +0100] Calling CreateDevice(cups-ksiegowosc,temp)
D [23/Mar/2012:08:08:26 +0100] created device /org/freedesktop/ColorManager/devices/cups_ksiegowosc
D [23/Mar/2012:08:08:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_ksiegowosc:AddProfile(/org/freedesktop/ColorManager/profiles/ksiegowosc_Gray__) [soft]
D [23/Mar/2012:08:08:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_ksiegowosc:AddProfile(/org/freedesktop/ColorManager/profiles/ksiegowosc_RGB__) [soft]
D [23/Mar/2012:08:08:26 +0100] cupsdRegisterPrinter(p=0x204ddc90(ksiegowosc))
D [23/Mar/2012:08:08:26 +0100] load_ppd: Loading /var/cache/cups/ksiegowosc.data...
D [23/Mar/2012:08:08:26 +0100] Calling DeleteDevice(cups-ksiegowosc)
D [23/Mar/2012:08:08:26 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:08:08:26 +0100] Using profile id of ksiegowosc-Gray..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(ksiegowosc-Gray..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/ksiegowosc_Gray__
D [23/Mar/2012:08:08:26 +0100] Using profile id of ksiegowosc-RGB..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(ksiegowosc-RGB..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/ksiegowosc_RGB__
I [23/Mar/2012:08:08:26 +0100] Registering ICC color profiles for "ksiegowosc"
D [23/Mar/2012:08:08:26 +0100] Calling CreateDevice(cups-ksiegowosc,temp)
D [23/Mar/2012:08:08:26 +0100] created device /org/freedesktop/ColorManager/devices/cups_ksiegowosc
D [23/Mar/2012:08:08:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_ksiegowosc:AddProfile(/org/freedesktop/ColorManager/profiles/ksiegowosc_Gray__) [soft]
W [23/Mar/2012:08:08:26 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/ksiegowosc_Gray__' has already been added
D [23/Mar/2012:08:08:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_ksiegowosc:AddProfile(/org/freedesktop/ColorManager/profiles/ksiegowosc_RGB__) [soft]
W [23/Mar/2012:08:08:26 +0100] failed to AddProfile: org.freedesktop.ColorManager.Failed:profile object path '/org/freedesktop/ColorManager/profiles/ksiegowosc_RGB__' has already been added
D [23/Mar/2012:08:08:26 +0100] cupsdRegisterPrinter(p=0x204ddc90(ksiegowosc))
D [23/Mar/2012:08:08:26 +0100] Loading printer lj1150...
D [23/Mar/2012:08:08:26 +0100] load_ppd: Loading /var/cache/cups/lj1150.data...
D [23/Mar/2012:08:08:26 +0100] Calling DeleteDevice(cups-lj1150)
D [23/Mar/2012:08:08:26 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:08:08:26 +0100] Using profile id of lj1150-Gray..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(lj1150-Gray..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/lj1150_Gray__
D [23/Mar/2012:08:08:26 +0100] Using profile id of lj1150-RGB..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(lj1150-RGB..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/lj1150_RGB__
I [23/Mar/2012:08:08:26 +0100] Registering ICC color profiles for "lj1150"
D [23/Mar/2012:08:08:26 +0100] Calling CreateDevice(cups-lj1150,temp)
D [23/Mar/2012:08:08:26 +0100] created device /org/freedesktop/ColorManager/devices/cups_lj1150
D [23/Mar/2012:08:08:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_lj1150:AddProfile(/org/freedesktop/ColorManager/profiles/lj1150_Gray__) [soft]
D [23/Mar/2012:08:08:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_lj1150:AddProfile(/org/freedesktop/ColorManager/profiles/lj1150_RGB__) [soft]
D [23/Mar/2012:08:08:26 +0100] cupsdRegisterPrinter(p=0x204f5828(lj1150))
D [23/Mar/2012:08:08:26 +0100] Loading printer PDF...
D [23/Mar/2012:08:08:26 +0100] load_ppd: Loading /var/cache/cups/PDF.data...
D [23/Mar/2012:08:08:26 +0100] Calling DeleteDevice(cups-PDF)
D [23/Mar/2012:08:08:26 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:08:08:26 +0100] Using profile id of PDF-Gray..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(PDF-Gray..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/PDF_Gray__
D [23/Mar/2012:08:08:26 +0100] Using profile id of PDF-RGB..
D [23/Mar/2012:08:08:26 +0100] Calling CreateProfile(PDF-RGB..,temp)
D [23/Mar/2012:08:08:26 +0100] created profile /org/freedesktop/ColorManager/profiles/PDF_RGB__
I [23/Mar/2012:08:08:26 +0100] Registering ICC color profiles for "PDF"
D [23/Mar/2012:08:08:26 +0100] Calling CreateDevice(cups-PDF,temp)
D [23/Mar/2012:08:08:26 +0100] created device /org/freedesktop/ColorManager/devices/cups_PDF
D [23/Mar/2012:08:08:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_PDF:AddProfile(/org/freedesktop/ColorManager/profiles/PDF_Gray__) [soft]
D [23/Mar/2012:08:08:27 +0100] Calling /org/freedesktop/ColorManager/devices/cups_PDF:AddProfile(/org/freedesktop/ColorManager/profiles/PDF_RGB__) [soft]
D [23/Mar/2012:08:08:27 +0100] cupsdRegisterPrinter(p=0x204fad60(PDF))
D [23/Mar/2012:08:08:27 +0100] Loading printer pietro...
D [23/Mar/2012:08:08:27 +0100] load_ppd: Loading /var/cache/cups/pietro.data...
D [23/Mar/2012:08:08:27 +0100] Calling DeleteDevice(cups-pietro)
D [23/Mar/2012:08:08:27 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:08:08:27 +0100] Using profile id of pietro-Gray..
D [23/Mar/2012:08:08:27 +0100] Calling CreateProfile(pietro-Gray..,temp)
D [23/Mar/2012:08:08:27 +0100] created profile /org/freedesktop/ColorManager/profiles/pietro_Gray__
D [23/Mar/2012:08:08:27 +0100] Using profile id of pietro-RGB..
D [23/Mar/2012:08:08:27 +0100] Calling CreateProfile(pietro-RGB..,temp)
D [23/Mar/2012:08:08:27 +0100] created profile /org/freedesktop/ColorManager/profiles/pietro_RGB__
I [23/Mar/2012:08:08:27 +0100] Registering ICC color profiles for "pietro"
D [23/Mar/2012:08:08:27 +0100] Calling CreateDevice(cups-pietro,temp)
D [23/Mar/2012:08:08:27 +0100] created device /org/freedesktop/ColorManager/devices/cups_pietro
D [23/Mar/2012:08:08:27 +0100] Calling /org/freedesktop/ColorManager/devices/cups_pietro:AddProfile(/org/freedesktop/ColorManager/profiles/pietro_Gray__) [soft]
D [23/Mar/2012:08:08:27 +0100] Calling /org/freedesktop/ColorManager/devices/cups_pietro:AddProfile(/org/freedesktop/ColorManager/profiles/pietro_RGB__) [soft]
D [23/Mar/2012:08:08:27 +0100] cupsdRegisterPrinter(p=0x2050eba0(pietro))
D [23/Mar/2012:08:08:27 +0100] Loading printer zakupy...
D [23/Mar/2012:08:08:27 +0100] load_ppd: Loading /var/cache/cups/zakupy.data...
D [23/Mar/2012:08:08:27 +0100] Calling DeleteDevice(cups-zakupy)
D [23/Mar/2012:08:08:27 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [23/Mar/2012:08:08:27 +0100] Using profile id of zakupy-Gray..
D [23/Mar/2012:08:08:27 +0100] Calling CreateProfile(zakupy-Gray..,temp)
D [23/Mar/2012:08:08:27 +0100] created profile /org/freedesktop/ColorManager/profiles/zakupy_Gray__
I [23/Mar/2012:08:08:27 +0100] Registering ICC color profiles for "zakupy"
D [23/Mar/2012:08:08:27 +0100] Calling CreateDevice(cups-zakupy,temp)
D [23/Mar/2012:08:08:27 +0100] created device /org/freedesktop/ColorManager/devices/cups_zakupy
D [23/Mar/2012:08:08:27 +0100] Calling /org/freedesktop/ColorManager/devices/cups_zakupy:AddProfile(/org/freedesktop/ColorManager/profiles/zakupy_Gray__) [soft]
D [23/Mar/2012:08:08:27 +0100] cupsdRegisterPrinter(p=0x20529db0(zakupy))
D [23/Mar/2012:08:08:27 +0100] cupsdLoadRemoteCache: Not loading remote cache.
I [23/Mar/2012:08:08:27 +0100] Loading job cache file "/var/cache/cups/job.cache"...
D [23/Mar/2012:08:08:27 +0100] [Job 63] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 64] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 65] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 66] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 67] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 68] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 69] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 70] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 71] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 72] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 73] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 74] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 75] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 76] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 77] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 78] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 79] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 80] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 81] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 82] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 83] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 84] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 85] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 86] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 87] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 88] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 89] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 90] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 91] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 92] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 93] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 94] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 95] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 96] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 97] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 98] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 99] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 100] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 101] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] [Job 102] Loading from cache...
D [23/Mar/2012:08:08:27 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [23/Mar/2012:08:08:27 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [23/Mar/2012:08:08:27 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
I [23/Mar/2012:08:08:27 +0100] Full reload complete.
D [23/Mar/2012:08:08:27 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [23/Mar/2012:08:08:27 +0100] Cleaning out old files in "/var/spool/cups/tmp"...
D [23/Mar/2012:08:08:27 +0100] Removed "/var/spool/cups/tmp/foomatic-uCpDvM"...
D [23/Mar/2012:08:08:27 +0100] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
I [23/Mar/2012:08:08:27 +0100] Cleaning out old files in "/var/cache/cups"...
I [23/Mar/2012:08:08:27 +0100] Listening to [v1.::1]:631 on fd 9...
I [23/Mar/2012:08:08:27 +0100] Listening to 127.0.0.1:631 on fd 10...
I [23/Mar/2012:08:08:27 +0100] Listening to /var/run/cups/cups.sock:631 on fd 11...
I [23/Mar/2012:08:08:27 +0100] Resuming new connection processing...
D [23/Mar/2012:08:08:27 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [23/Mar/2012:08:08:27 +0100] Discarding unused server-started event...
D [23/Mar/2012:08:08:28 +0100] Report: clients=0
D [23/Mar/2012:08:08:28 +0100] Report: jobs=40
D [23/Mar/2012:08:08:28 +0100] Report: jobs-active=0
D [23/Mar/2012:08:08:28 +0100] Report: printers=7
D [23/Mar/2012:08:08:28 +0100] Report: printers-implicit=0
D [23/Mar/2012:08:08:28 +0100] Report: stringpool-string-count=45066
D [23/Mar/2012:08:08:28 +0100] Report: stringpool-alloc-bytes=16408
D [23/Mar/2012:08:08:28 +0100] Report: stringpool-total-bytes=831672
D [23/Mar/2012:08:09:50 +0100] cupsdAcceptClient: 14 from localhost (Domain)
D [23/Mar/2012:08:09:50 +0100] Avahi client started
D [23/Mar/2012:08:09:50 +0100] Report: clients=1
D [23/Mar/2012:08:09:50 +0100] Report: jobs=40
D [23/Mar/2012:08:09:50 +0100] Report: jobs-active=0
D [23/Mar/2012:08:09:50 +0100] Report: printers=7
D [23/Mar/2012:08:09:50 +0100] Report: printers-implicit=0
D [23/Mar/2012:08:09:50 +0100] Report: stringpool-string-count=45066
D [23/Mar/2012:08:09:50 +0100] Report: stringpool-alloc-bytes=16408
D [23/Mar/2012:08:09:50 +0100] Report: stringpool-total-bytes=831672
D [23/Mar/2012:08:09:50 +0100] cupsdReadClient: 14 POST /admin/ HTTP/1.1
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:09:50 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:09:50 +0100] cupsdReadClient: 14 1.1 Purge-Jobs 1
D [23/Mar/2012:08:09:50 +0100] Purge-Jobs ipp://localhost/printers/
D [23/Mar/2012:08:09:50 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:09:50 +0100] [Job 63] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
I [23/Mar/2012:08:09:50 +0100] [Job 63] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 63] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 64] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 64] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 64] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 65] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 65] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 65] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 66] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 66] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 66] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 67] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 67] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 67] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 68] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 68] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 68] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 69] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 69] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 69] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 70] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 70] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 70] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 71] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 71] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 71] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 72] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 72] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 72] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 73] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 73] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 73] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 74] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 74] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 74] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 75] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 75] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 75] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 76] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 76] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 76] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 77] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 77] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 77] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 78] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 78] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 78] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 79] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 79] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 79] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 80] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 80] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 80] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 81] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 81] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 81] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 82] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 82] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 82] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 83] Loading attributes...
D [23/Mar/2012:08:09:50 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:50 +0100] [Job 83] Job purged by user.
D [23/Mar/2012:08:09:50 +0100] [Job 83] Unloading...
D [23/Mar/2012:08:09:50 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:50 +0100] [Job 84] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 84] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 84] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 85] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 85] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 85] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 86] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 86] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 86] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 87] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 87] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 87] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 88] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 88] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 88] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 89] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 89] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 89] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 90] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 90] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 90] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 91] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 91] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 91] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 92] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 92] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 92] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 93] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 93] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 93] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 94] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 94] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 94] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 95] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 95] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 95] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 96] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 96] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 96] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 97] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 97] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 97] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 98] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 98] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 98] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 99] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 99] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 99] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 100] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 100] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 100] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 101] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 101] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 101] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] [Job 102] Loading attributes...
D [23/Mar/2012:08:09:51 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] [Job 102] Job purged by user.
D [23/Mar/2012:08:09:51 +0100] [Job 102] Unloading...
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:09:51 +0100] All jobs were purged by "karol".
D [23/Mar/2012:08:09:51 +0100] Returning IPP successful-ok for Purge-Jobs (ipp://localhost/printers/) from localhost
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:09:51 +0100] cupsdReadClient: 14 WAITING Closing on EOF
D [23/Mar/2012:08:09:51 +0100] cupsdCloseClient: 14
D [23/Mar/2012:08:09:51 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [23/Mar/2012:08:10:21 +0100] Saving subscriptions.conf...
D [23/Mar/2012:08:10:21 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [23/Mar/2012:08:11:16 +0100] Report: clients=0
D [23/Mar/2012:08:11:16 +0100] Report: jobs=0
D [23/Mar/2012:08:11:16 +0100] Report: jobs-active=0
D [23/Mar/2012:08:11:16 +0100] Report: printers=7
D [23/Mar/2012:08:11:16 +0100] Report: printers-implicit=0
D [23/Mar/2012:08:11:16 +0100] Report: stringpool-string-count=47146
D [23/Mar/2012:08:11:16 +0100] Report: stringpool-alloc-bytes=17656
D [23/Mar/2012:08:11:16 +0100] Report: stringpool-total-bytes=873512
D [23/Mar/2012:08:12:16 +0100] cupsdAcceptClient: 14 from localhost (Domain)
D [23/Mar/2012:08:12:16 +0100] Report: clients=1
D [23/Mar/2012:08:12:16 +0100] Report: jobs=0
D [23/Mar/2012:08:12:16 +0100] Report: jobs-active=0
D [23/Mar/2012:08:12:16 +0100] Report: printers=7
D [23/Mar/2012:08:12:16 +0100] Report: printers-implicit=0
D [23/Mar/2012:08:12:16 +0100] Report: stringpool-string-count=47146
D [23/Mar/2012:08:12:16 +0100] Report: stringpool-alloc-bytes=17656
D [23/Mar/2012:08:12:16 +0100] Report: stringpool-total-bytes=873512
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:16 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:16 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:16 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:16 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:12:17 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:12:17 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:12:17 +0100] CUPS-Get-Default
D [23/Mar/2012:08:12:17 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:12:17 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] Report: clients=1
D [23/Mar/2012:08:13:18 +0100] Report: jobs=0
D [23/Mar/2012:08:13:18 +0100] Report: jobs-active=0
D [23/Mar/2012:08:13:18 +0100] Report: printers=7
D [23/Mar/2012:08:13:18 +0100] Report: printers-implicit=0
D [23/Mar/2012:08:13:18 +0100] Report: stringpool-string-count=47148
D [23/Mar/2012:08:13:18 +0100] Report: stringpool-alloc-bytes=17688
D [23/Mar/2012:08:13:18 +0100] Report: stringpool-total-bytes=873544
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Printers
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [23/Mar/2012:08:13:18 +0100] CUPS-Get-Default
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 16 1.1 Get-Printer-Attributes 1
D [23/Mar/2012:08:13:18 +0100] Get-Printer-Attributes ipp://localhost:631/printers/Canon
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/Canon) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 16 POST /printers/Canon HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 16 1.1 Create-Job 1
D [23/Mar/2012:08:13:18 +0100] Create-Job ipp://localhost:631/printers/Canon
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(----J-)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [23/Mar/2012:08:13:18 +0100] add_job: requesting-user-name="karol"
I [23/Mar/2012:08:13:18 +0100] [Job 103] Adding start banner page "none".
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:13:18 +0100] [Job 103] Queued on "Canon" by "karol".
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/Canon) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 16 POST /printers/Canon HTTP/1.1
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:18 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 16 1.1 Send-Document 1
D [23/Mar/2012:08:13:18 +0100] Send-Document ipp://localhost:631/printers/Canon
D [23/Mar/2012:08:13:18 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:18 +0100] [Job 103] Auto-typing file...
D [23/Mar/2012:08:13:18 +0100] [Job 103] Request file type is application/postscript.
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(----J-)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [23/Mar/2012:08:13:18 +0100] [Job 103] File of type application/postscript queued by "karol".
I [23/Mar/2012:08:13:18 +0100] [Job 103] Adding end banner page "none".
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(----J-)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(----J-)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:18 +0100] [Job 103] job-sheets=none,none
D [23/Mar/2012:08:13:18 +0100] [Job 103] argv[0]="Canon"
D [23/Mar/2012:08:13:18 +0100] [Job 103] argv[1]="103"
D [23/Mar/2012:08:13:18 +0100] [Job 103] argv[2]="karol"
D [23/Mar/2012:08:13:18 +0100] [Job 103] argv[3]="NowyWzorFVT"
D [23/Mar/2012:08:13:18 +0100] [Job 103] argv[4]="1"
D [23/Mar/2012:08:13:18 +0100] [Job 103] argv[5]="BindingLocation=LongEdge noCollate finishings=3 InputSlot=MPT landscape media=A4 number-up=1 outputorder=normal sides=one-sided job-uuid=urn:uuid:4805a608-315a-3934-4595-57b8f26c0b68 job-originating-host-name=localhost time-at-creation=1332486798 time-at-processing=1332486798 Duplex=None PageSize=A4"
D [23/Mar/2012:08:13:18 +0100] [Job 103] argv[6]="/var/spool/cups/d00103-001"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[8]="HOME=/var/spool/cups/tmp"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[10]="SERVER_ADMIN=root@ubuntu"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[11]="SOFTWARE=CUPS/1.5.0"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[13]="USER=root"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[16]="IPP_PORT=631"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[17]="CHARSET=utf-8"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[18]="LANG=pl_PL.UTF-8"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[19]="PPD=/etc/cups/ppd/Canon.ppd"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[20]="RIP_MAX_CACHE=128m"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[21]="CONTENT_TYPE=application/postscript"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[22]="DEVICE_URI=socket://192.168.0.33"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[23]="PRINTER_INFO=Canon iR3035"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[24]="PRINTER_LOCATION=Kserokopiarnia"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[25]="PRINTER=Canon"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[26]="PRINTER_STATE_REASONS=media-low-report"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[27]="CUPS_FILETYPE=document"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[28]="FINAL_CONTENT_TYPE=printer/Canon"
D [23/Mar/2012:08:13:18 +0100] [Job 103] envp[29]="AUTH_I****"
I [23/Mar/2012:08:13:18 +0100] [Job 103] Started filter /usr/lib/cups/filter/pstopdf (PID 22189)
I [23/Mar/2012:08:13:18 +0100] [Job 103] Started filter /usr/lib/cups/filter/pdftopdf (PID 22190)
I [23/Mar/2012:08:13:18 +0100] [Job 103] Started filter /usr/lib/cups/filter/foomatic-rip (PID 22191)
I [23/Mar/2012:08:13:18 +0100] [Job 103] Started backend /usr/lib/cups/backend/socket (PID 22192)
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:18 +0100] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/Canon) from localhost
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [23/Mar/2012:08:13:18 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:18 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:18 +0100] [Job 103] pstopdf 6 args: 103 karol NowyWzorFVT 1 BindingLocation=LongEdge noCollate finishings=3 InputSlot=MPT landscape media=A4 number-up=1 outputorder=normal sides=one-sided job-uuid=urn:uuid:4805a608-315a-3934-4595-57b8f26c0b68 job-originating-host-name=localhost time-at-creation=1332486798 time-at-processing=1332486798 Duplex=None PageSize=A4 /var/spool/cups/d00103-001
D [23/Mar/2012:08:13:18 +0100] [Job 103] PPD: /etc/cups/ppd/Canon.ppd
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: +connecting-to-device
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:18 +0100] [Job 103] Looking up "192.168.0.33"...
D [23/Mar/2012:08:13:18 +0100] [Job 103] Getting input from file 
D [23/Mar/2012:08:13:18 +0100] [Job 103] foomatic-rip version 4.0.9.241 running...
D [23/Mar/2012:08:13:18 +0100] [Job 103] Parsing PPD file ...
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Opt2CF
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option OptSPD
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option OptENV
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option OptFIN
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option OptPCU
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option WideA4
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Destination
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Mailbox
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option UserPassword
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option UserID
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option SecuredPassword
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option CNResolution
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Resolution
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option GSResolution
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option JCLResolution
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option ColorSpace
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option InputSlot
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option MediaType
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Duplex
D [23/Mar/2012:08:13:18 +0100] [Job 103] ATTR: marker-colors=#000000,none
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:18 +0100] [Job 103] ATTR: marker-names="C-EXV 12","Waste Toner"
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:18 +0100] [Job 103] ATTR: marker-types=toner,wasteToner
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:18 +0100] [Job 103] ATTR: marker-levels=100,100
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:18 +0100] [Job 103] new_supply_state=0, change_state=ffff
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -developer-low-report
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -developer-empty-warning
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -marker-supply-low-report
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -marker-supply-empty-warning
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -opc-near-eol-report
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -opc-life-over-warning
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -toner-low-report
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -toner-empty-warning
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:18 +0100] [Job 103] new_state=c000, change_state=ffff
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: +media-low-report
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: +media-empty-warning
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -door-open-report
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -media-jam-warning
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -input-tray-missing-warning
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -output-tray-missing-warning
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -marker-supply-missing-warning
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -output-area-almost-full-report
D [23/Mar/2012:08:13:18 +0100] [Job 103] STATE: -output-area-full-warning
D [23/Mar/2012:08:13:18 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:18 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:18 +0100] [Job 103] backendWaitLoop(snmp_fd=5, addr=0x22c5a8e4, side_cb=0xcf5370)
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Booklet
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option BindingLocation
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Finishing
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Interleave
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Staple
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Punch
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option CNOutput
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option ImageRefine
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option LineRefine
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option TonerSave
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option ScreenProc
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Transfer
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option LeadingEdge
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option PageSize
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option ImageableArea
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option PaperDimension
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option Font
D [23/Mar/2012:08:13:18 +0100] [Job 103] Added option ColorSep
D [23/Mar/2012:08:13:18 +0100] [Job 103] 
D [23/Mar/2012:08:13:18 +0100] [Job 103] Parameter Summary
D [23/Mar/2012:08:13:18 +0100] [Job 103] -----------------
D [23/Mar/2012:08:13:18 +0100] [Job 103] 
D [23/Mar/2012:08:13:18 +0100] [Job 103] Spooler: cups
D [23/Mar/2012:08:13:18 +0100] [Job 103] Printer: Canon
D [23/Mar/2012:08:13:18 +0100] [Job 103] Shell: /bin/bash
D [23/Mar/2012:08:13:18 +0100] [Job 103] PPD file: /etc/cups/ppd/Canon.ppd
D [23/Mar/2012:08:13:18 +0100] [Job 103] ATTR file: 
D [23/Mar/2012:08:13:18 +0100] [Job 103] Printer model: Canon iR3035/iR3045 PCL
D [23/Mar/2012:08:13:18 +0100] [Job 103] Job title: NowyWzorFVT
D [23/Mar/2012:08:13:18 +0100] [Job 103] File(s) to be printed:
D [23/Mar/2012:08:13:18 +0100] [Job 103] <STDIN>
D [23/Mar/2012:08:13:18 +0100] [Job 103] 
D [23/Mar/2012:08:13:18 +0100] [Job 103] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [23/Mar/2012:08:13:18 +0100] [Job 103] Printing system options:
D [23/Mar/2012:08:13:18 +0100] [Job 103] Pondering option 'noCollate'
D [23/Mar/2012:08:13:18 +0100] [Job 103] Unknown boolean option "noCollate".
D [23/Mar/2012:08:13:18 +0100] [Job 103] Pondering option 'finishings=3'
D [23/Mar/2012:08:13:18 +0100] [Job 103] Unknown option finishings=3.
D [23/Mar/2012:08:13:18 +0100] [Job 103] Pondering option 'landscape'
D [23/Mar/2012:08:13:18 +0100] [Job 103] Unknown boolean option "landscape".
D [23/Mar/2012:08:13:18 +0100] [Job 103] Pondering option 'media=A4'
D [23/Mar/2012:08:13:18 +0100] [Job 103] Pondering option 'number-up=1'
D [23/Mar/2012:08:13:19 +0100] [Job 103] Unknown option number-up=1.
D [23/Mar/2012:08:13:19 +0100] [Job 103] Pondering option 'outputorder=normal'
D [23/Mar/2012:08:13:19 +0100] [Job 103] Unknown option outputorder=normal.
D [23/Mar/2012:08:13:19 +0100] [Job 103] Pondering option 'sides=one-sided'
D [23/Mar/2012:08:13:19 +0100] [Job 103] Pondering option 'job-uuid=urn:uuid:4805a608-315a-3934-4595-57b8f26c0b68'
D [23/Mar/2012:08:13:19 +0100] [Job 103] Unknown option job-uuid=urn:uuid:4805a608-315a-3934-4595-57b8f26c0b68.
D [23/Mar/2012:08:13:19 +0100] [Job 103] Pondering option 'job-originating-host-name=localhost'
D [23/Mar/2012:08:13:19 +0100] [Job 103] Unknown option job-originating-host-name=localhost.
D [23/Mar/2012:08:13:19 +0100] [Job 103] Pondering option 'time-at-creation=1332486798'
D [23/Mar/2012:08:13:19 +0100] [Job 103] Unknown option time-at-creation=1332486798.
D [23/Mar/2012:08:13:19 +0100] [Job 103] Pondering option 'time-at-processing=1332486798'
D [23/Mar/2012:08:13:19 +0100] [Job 103] Unknown option time-at-processing=1332486798.
D [23/Mar/2012:08:13:19 +0100] [Job 103] Options from the PPD file:
D [23/Mar/2012:08:13:19 +0100] [Job 103] Pondering option 'BindingLocation=LongEdge'
D [23/Mar/2012:08:13:19 +0100] [Job 103] Pondering option 'InputSlot=MPT'
D [23/Mar/2012:08:13:19 +0100] [Job 103] Pondering option 'Duplex=None'
D [23/Mar/2012:08:13:19 +0100] [Job 103] Pondering option 'PageSize=A4'
D [23/Mar/2012:08:13:19 +0100] [Job 103] 
D [23/Mar/2012:08:13:19 +0100] [Job 103] ================================================
D [23/Mar/2012:08:13:19 +0100] [Job 103] 
D [23/Mar/2012:08:13:19 +0100] [Job 103] File: <STDIN>
D [23/Mar/2012:08:13:19 +0100] [Job 103] 
D [23/Mar/2012:08:13:19 +0100] [Job 103] ================================================
D [23/Mar/2012:08:13:19 +0100] [Job 103] 
D [23/Mar/2012:08:13:19 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:19 +0100] Get-Notifications /
D [23/Mar/2012:08:13:19 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:19 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 1.1 Get-Job-Attributes 1
D [23/Mar/2012:08:13:19 +0100] Get-Job-Attributes ipp://localhost/jobs/103
D [23/Mar/2012:08:13:19 +0100] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/103) from localhost
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:19 +0100] [Job 103] Resolution: 
D [23/Mar/2012:08:13:19 +0100] [Job 103] Page size: A4
D [23/Mar/2012:08:13:19 +0100] [Job 103] Width: 595, height: 842, absolute margins: 7.0867, 7.0867, 587.9133, 834.9133
D [23/Mar/2012:08:13:19 +0100] [Job 103] Relative margins: 7.0867, 7.0867, 7.0867, 7.0867
D [23/Mar/2012:08:13:19 +0100] [Job 103] PPD options: -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842
D [23/Mar/2012:08:13:19 +0100] [Job 103] PostScript to be injected: 
D [23/Mar/2012:08:13:19 +0100] cupsdAcceptClient: 18 from localhost (Domain)
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 18 1.1 Get-Printer-Attributes 1
D [23/Mar/2012:08:13:19 +0100] Get-Printer-Attributes 
D [23/Mar/2012:08:13:19 +0100] Get-Printer-Attributes client-error-not-found: The printer or class does not exist.
D [23/Mar/2012:08:13:19 +0100] Returning IPP client-error-not-found for Get-Printer-Attributes () from localhost
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 18 WAITING Closing on EOF
D [23/Mar/2012:08:13:19 +0100] cupsdCloseClient: 18
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:19 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:19 +0100] Get-Notifications /
D [23/Mar/2012:08:13:19 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:19 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:19 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:19 +0100] Get-Notifications /
D [23/Mar/2012:08:13:19 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:19 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:19 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:19 +0100] Get-Notifications /
D [23/Mar/2012:08:13:19 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:19 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:19 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:19 +0100] Get-Notifications /
D [23/Mar/2012:08:13:19 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:19 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:19 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:19 +0100] Get-Notifications /
D [23/Mar/2012:08:13:19 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:19 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:19 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:19 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:19 +0100] [Job 103] Running cat | /usr/bin/gs -q -dNOPAUSE -dBATCH -sDEVICE=pdfwrite -dCompatibilityLevel=1.3 -dAutoRotatePages=/None -dAutoFilterColorImages=false                -dNOPLATFONTS -dPARANOIDSAFER -dNOINTERPOLATE -sstdout=%stderr -dColorImageFilter=/FlateEncode                 -dPDFSETTINGS=/printer                 -dColorConversionStrategy=/LeaveColorUnchanged -dDoNumCopies -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -sOutputFile=-  -c .setpdfwrite -f -
D [23/Mar/2012:08:13:20 +0100] PID 22189 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [23/Mar/2012:08:13:20 +0100] [Job 103] Filetype: PDF
D [23/Mar/2012:08:13:20 +0100] [Job 103] Driver does not understand PDF input, converting to PostScript
D [23/Mar/2012:08:13:20 +0100] [Job 103] Storing temporary files in /var/spool/cups/tmp
D [23/Mar/2012:08:13:20 +0100] PID 22190 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [23/Mar/2012:08:13:20 +0100] [Job 103] Starting process "pdf-to-ps" (generation 1)
D [23/Mar/2012:08:13:20 +0100] [Job 103] Filetype: PostScript
D [23/Mar/2012:08:13:20 +0100] [Job 103] Reading PostScript input ...
D [23/Mar/2012:08:13:20 +0100] [Job 103] --> This document is DSC-conforming!
D [23/Mar/2012:08:13:20 +0100] [Job 103] 
D [23/Mar/2012:08:13:20 +0100] [Job 103] -----------
D [23/Mar/2012:08:13:20 +0100] [Job 103] Found: %%BeginProlog
D [23/Mar/2012:08:13:20 +0100] [Job 103] Inserting option code into "Prolog" section.
D [23/Mar/2012:08:13:20 +0100] [Job 103] Found: %%EndProlog
D [23/Mar/2012:08:13:20 +0100] [Job 103] 
D [23/Mar/2012:08:13:20 +0100] [Job 103] -----------
D [23/Mar/2012:08:13:20 +0100] [Job 103] New page: %%Page: 1 1
D [23/Mar/2012:08:13:20 +0100] [Job 103] "Setup" section is missing, inserting it.
D [23/Mar/2012:08:13:20 +0100] [Job 103] Inserting PostScript code for CUPS' page accounting
D [23/Mar/2012:08:13:20 +0100] [Job 103] Inserting option code into "Setup" section.
D [23/Mar/2012:08:13:20 +0100] [Job 103] 
D [23/Mar/2012:08:13:20 +0100] [Job 103] Found: %%BeginPageSetup
D [23/Mar/2012:08:13:20 +0100] [Job 103] Inserting option code into "PageSetup" section.
D [23/Mar/2012:08:13:20 +0100] [Job 103] Flushing FIFO.
D [23/Mar/2012:08:13:20 +0100] [Job 103] 
D [23/Mar/2012:08:13:20 +0100] [Job 103] Starting renderer with command: "gs -sstdout=%stderr  -dBATCH -dPARANOIDSAFER -dPDFFitPage  -sDEVICE=ljet4 -dNOPAUSE -sPAPERSIZE=a4 -sOutputFile=%stdout -_  | sicgsfilter -MPCL -NP  -A1 -q0 -s1 -d0 -a0 -G0 -l0 -i0 -ukarol -V"NowyWzorFVT" -n1 "
D [23/Mar/2012:08:13:20 +0100] [Job 103] Starting process "kid3" (generation 1)
D [23/Mar/2012:08:13:20 +0100] [Job 103] Starting process "kid4" (generation 2)
D [23/Mar/2012:08:13:20 +0100] [Job 103] Starting process "renderer" (generation 2)
D [23/Mar/2012:08:13:20 +0100] [Job 103] JCL: %-12345X@PJL
D [23/Mar/2012:08:13:20 +0100] [Job 103] <job data> 
D [23/Mar/2012:08:13:20 +0100] [Job 103] 
D [23/Mar/2012:08:13:20 +0100] [Job 103] GPL Ghostscript 9.04 (2011-08-05)
D [23/Mar/2012:08:13:20 +0100] [Job 103] Copyright (C) 2011 Artifex Software, Inc.  All rights reserved.
D [23/Mar/2012:08:13:20 +0100] [Job 103] This software comes with NO WARRANTY: see the file PUBLIC for details.
D [23/Mar/2012:08:13:21 +0100] [Job 103] 
D [23/Mar/2012:08:13:21 +0100] [Job 103] Closing renderer
D [23/Mar/2012:08:13:21 +0100] [Job 103] PAGE: 1 1
D [23/Mar/2012:08:13:21 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:21 +0100] [Job 103] Connecting to 192.168.0.33:9100
I [23/Mar/2012:08:13:21 +0100] [Job 103] Connecting to printer.
D [23/Mar/2012:08:13:21 +0100] [Job 103] Set job-printer-state-message to "Connecting to printer.", current level=INFO
D [23/Mar/2012:08:13:21 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:21 +0100] [Job 103] STATE: -connecting-to-device
D [23/Mar/2012:08:13:21 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
I [23/Mar/2012:08:13:21 +0100] [Job 103] Connected to printer.
D [23/Mar/2012:08:13:21 +0100] [Job 103] Set job-printer-state-message to "Connected to printer.", current level=INFO
D [23/Mar/2012:08:13:21 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] [Job 103] Connected to 192.168.0.33:9100...
D [23/Mar/2012:08:13:21 +0100] [Job 103] backendRunLoop(print_fd=0, device_fd=6, snmp_fd=5, addr=0x22c5a8e4, use_bc=1, side_cb=0xcf5370)
D [23/Mar/2012:08:13:21 +0100] [Job 103] Read 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] ATTR: marker-levels=100,100
D [23/Mar/2012:08:13:21 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] [Job 103] new_supply_state=0, change_state=0
D [23/Mar/2012:08:13:21 +0100] [Job 103] new_state=c000, change_state=0
D [23/Mar/2012:08:13:21 +0100] [Job 103] renderer exited with status 0
D [23/Mar/2012:08:13:21 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:21 +0100] Get-Notifications /
D [23/Mar/2012:08:13:21 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:21 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [23/Mar/2012:08:13:21 +0100] [Job 103] Wrote 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Read 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] kid4 exited with status 0
D [23/Mar/2012:08:13:21 +0100] [Job 103] kid3 finished
D [23/Mar/2012:08:13:21 +0100] [Job 103] Wrote 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Read 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Wrote 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Read 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Wrote 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Read 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] kid3 exited with status 0
D [23/Mar/2012:08:13:21 +0100] [Job 103] pdf-to-ps exited with status 0
D [23/Mar/2012:08:13:21 +0100] [Job 103] 
D [23/Mar/2012:08:13:21 +0100] [Job 103] Closing foomatic-rip.
D [23/Mar/2012:08:13:21 +0100] [Job 103] Wrote 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Read 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Wrote 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Read 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] PID 22191 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.
D [23/Mar/2012:08:13:21 +0100] [Job 103] Wrote 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Read 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Wrote 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Read 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Wrote 8192 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Read 1168 bytes of print data...
D [23/Mar/2012:08:13:21 +0100] [Job 103] Wrote 1168 bytes of print data...
I [23/Mar/2012:08:13:21 +0100] [Job 103] Waiting for printer to finish.
D [23/Mar/2012:08:13:21 +0100] [Job 103] Set job-printer-state-message to "Waiting for printer to finish.", current level=INFO
D [23/Mar/2012:08:13:21 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:21 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:21 +0100] Get-Notifications /
D [23/Mar/2012:08:13:21 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:21 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:21 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:21 +0100] Get-Notifications /
D [23/Mar/2012:08:13:21 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:21 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:21 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:21 +0100] Get-Notifications /
D [23/Mar/2012:08:13:21 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:21 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [23/Mar/2012:08:13:21 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:21 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:22 +0100] Get-Notifications /
D [23/Mar/2012:08:13:22 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:22 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:22 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:22 +0100] [Job 103] ATTR: marker-levels=100,100
D [23/Mar/2012:08:13:22 +0100] cupsdMarkDirty(P-----)
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:22 +0100] [Job 103] new_supply_state=0, change_state=0
D [23/Mar/2012:08:13:22 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:22 +0100] [Job 103] new_state=c000, change_state=0
I [23/Mar/2012:08:13:22 +0100] [Job 103] Ready to print.
D [23/Mar/2012:08:13:22 +0100] [Job 103] Set job-printer-state-message to "Ready to print.", current level=INFO
D [23/Mar/2012:08:13:22 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:22 +0100] PID 22192 (/usr/lib/cups/backend/socket) exited with no errors.
D [23/Mar/2012:08:13:22 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
I [23/Mar/2012:08:13:22 +0100] [Job 103] Job completed.
D [23/Mar/2012:08:13:22 +0100] cupsdMarkDirty(----J-)
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdMarkDirty(-----S)
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:22 +0100] Get-Notifications /
D [23/Mar/2012:08:13:22 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:22 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:22 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:22 +0100] Get-Notifications /
D [23/Mar/2012:08:13:22 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:22 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:22 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdAuthorize: No authentication data provided.
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 1.1 Get-Notifications 1
D [23/Mar/2012:08:13:22 +0100] Get-Notifications /
D [23/Mar/2012:08:13:22 +0100] cupsdIsAuthorized: requesting-user-name="karol"
D [23/Mar/2012:08:13:22 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [23/Mar/2012:08:13:22 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [23/Mar/2012:08:13:22 +0100] cupsdCloseClient: 16
D [23/Mar/2012:08:13:22 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [23/Mar/2012:08:13:23 +0100] [Job 103] Unloading...
I [23/Mar/2012:08:13:49 +0100] Saving printers.conf...
I [23/Mar/2012:08:13:49 +0100] Saving job.cache...
I [23/Mar/2012:08:13:50 +0100] Saving subscriptions.conf...
D [23/Mar/2012:08:13:50 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [23/Mar/2012:08:14:37 +0100] Report: clients=1
D [23/Mar/2012:08:14:37 +0100] Report: jobs=1
D [23/Mar/2012:08:14:37 +0100] Report: jobs-active=0
D [23/Mar/2012:08:14:37 +0100] Report: printers=7
D [23/Mar/2012:08:14:37 +0100] Report: printers-implicit=0
D [23/Mar/2012:08:14:37 +0100] Report: stringpool-string-count=48520
D [23/Mar/2012:08:14:37 +0100] Report: stringpool-alloc-bytes=18472
D [23/Mar/2012:08:14:37 +0100] Report: stringpool-total-bytes=901608
D [23/Mar/2012:08:17:31 +0100] cupsdReadClient: 14 WAITING Closing on EOF
D [23/Mar/2012:08:17:31 +0100] cupsdCloseClient: 14
D [23/Mar/2012:08:17:31 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [23/Mar/2012:08:17:31 +0100] Report: clients=0
D [23/Mar/2012:08:17:31 +0100] Report: jobs=1
D [23/Mar/2012:08:17:31 +0100] Report: jobs-active=0
D [23/Mar/2012:08:17:31 +0100] Report: printers=7
D [23/Mar/2012:08:17:31 +0100] Report: printers-implicit=0
D [23/Mar/2012:08:17:31 +0100] Report: stringpool-string-count=48520
D [23/Mar/2012:08:17:31 +0100] Report: stringpool-alloc-bytes=18472
D [23/Mar/2012:08:17:31 +0100] Report: stringpool-total-bytes=901608