W [13/Jun/2012:09:41:20 -0700] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'HP-Deskjet-1050-J410-series-Gray..' already exists W [13/Jun/2012:09:41:20 -0700] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'HP-Deskjet-1050-J410-series-RGB..' already exists W [13/Jun/2012:09:41:20 -0700] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-HP-Deskjet-1050-J410-series' already exists I [13/Jun/2012:10:40:39 -0700] Remote access is disabled. D [13/Jun/2012:10:40:39 -0700] Added auto ServerAlias Stonau I [13/Jun/2012:10:40:40 -0700] Loaded configuration file "/etc/cups/cupsd.conf" I [13/Jun/2012:10:40:40 -0700] Using default TempDir of /var/spool/cups/tmp... I [13/Jun/2012:10:40:40 -0700] Configured for up to 100 clients. I [13/Jun/2012:10:40:40 -0700] Allowing up to 100 client connections per host. I [13/Jun/2012:10:40:40 -0700] Using policy "default" as the default. D [13/Jun/2012:10:40:40 -0700] load_ppd: Loading /var/cache/cups/HP-Deskjet-1050-J410-series.data... D [13/Jun/2012:10:40:40 -0700] Calling DeleteDevice(cups-HP-Deskjet-1050-J410-series) D [13/Jun/2012:10:40:40 -0700] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)' D [13/Jun/2012:10:40:40 -0700] Using profile id of HP-Deskjet-1050-J410-series-Gray.. D [13/Jun/2012:10:40:40 -0700] Calling CreateProfile(HP-Deskjet-1050-J410-series-Gray..,temp) W [13/Jun/2012:10:40:41 -0700] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'HP-Deskjet-1050-J410-series-Gray..' already exists D [13/Jun/2012:10:40:41 -0700] Using profile id of HP-Deskjet-1050-J410-series-RGB.. D [13/Jun/2012:10:40:41 -0700] Calling CreateProfile(HP-Deskjet-1050-J410-series-RGB..,temp) W [13/Jun/2012:10:40:41 -0700] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'HP-Deskjet-1050-J410-series-RGB..' already exists I [13/Jun/2012:10:40:41 -0700] Registering ICC color profiles for "HP-Deskjet-1050-J410-series" D [13/Jun/2012:10:40:41 -0700] Calling CreateDevice(cups-HP-Deskjet-1050-J410-series,temp) W [13/Jun/2012:10:40:41 -0700] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-HP-Deskjet-1050-J410-series' already exists D [13/Jun/2012:10:40:41 -0700] cupsdRegisterPrinter(p=0x208a0f18(HP-Deskjet-1050-J410-series)) D [13/Jun/2012:10:40:41 -0700] cupsdMarkDirty(---p--) D [13/Jun/2012:10:40:41 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs" I [13/Jun/2012:10:40:41 -0700] Partial reload complete. I [13/Jun/2012:10:40:41 -0700] Listening to [v1.::1]:631 on fd 9... I [13/Jun/2012:10:40:41 -0700] Listening to 127.0.0.1:631 on fd 10... I [13/Jun/2012:10:40:41 -0700] Listening to /var/run/cups/cups.sock:631 on fd 11... I [13/Jun/2012:10:40:41 -0700] Resuming new connection processing... D [13/Jun/2012:10:40:41 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:40:41 -0700] Notifier dbus started - PID = 15419 D [13/Jun/2012:10:40:41 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:40:41 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:40:41 -0700] Report: clients=0 D [13/Jun/2012:10:40:41 -0700] Report: jobs=3 D [13/Jun/2012:10:40:41 -0700] Report: jobs-active=1 D [13/Jun/2012:10:40:41 -0700] Report: printers=1 D [13/Jun/2012:10:40:41 -0700] Report: printers-implicit=0 D [13/Jun/2012:10:40:41 -0700] Report: stringpool-string-count=4143 D [13/Jun/2012:10:40:41 -0700] Report: stringpool-alloc-bytes=11104 D [13/Jun/2012:10:40:41 -0700] Report: stringpool-total-bytes=83832 D [13/Jun/2012:10:40:41 -0700] PID 15128 (/usr/lib/cups/notifier/dbus) was terminated normally with signal 15. D [13/Jun/2012:10:40:41 -0700] cupsdAcceptClient: 17 from localhost (Domain) D [13/Jun/2012:10:40:42 -0700] [Notifier] state=3 D [13/Jun/2012:10:40:42 -0700] [Notifier] Connected to D-BUS D [13/Jun/2012:10:40:59 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:40:59 -0700] cupsdReadClient: 19 GET /admin/conf/cupsd.conf HTTP/1.1 D [13/Jun/2012:10:40:59 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:40:59 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:40:59 -0700] cupsdIsAuthorized: username="" D [13/Jun/2012:10:40:59 -0700] cupsdSendHeader: 19 WWW-Authenticate: Basic realm="CUPS", trc="y" D [13/Jun/2012:10:40:59 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:40:59 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:40:59 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:40:59 -0700] cupsdReadClient: 19 GET /admin/conf/cupsd.conf HTTP/1.1 D [13/Jun/2012:10:40:59 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:40:59 -0700] cupsdAuthorize: Authorized as qian using PeerCred D [13/Jun/2012:10:40:59 -0700] cupsdIsAuthorized: username="qian" D [13/Jun/2012:10:40:59 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:40:59 -0700] cupsdReadClient: 19 GET /admin/conf/cupsd.conf HTTP/1.1 D [13/Jun/2012:10:40:59 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:40:59 -0700] cupsdAuthorize: Authorized as qian using PeerCred D [13/Jun/2012:10:40:59 -0700] cupsdIsAuthorized: username="qian" D [13/Jun/2012:10:40:59 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:40:59 -0700] cupsdReadClient: 19 PUT /admin/conf/cupsd.conf HTTP/1.1 D [13/Jun/2012:10:40:59 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:40:59 -0700] cupsdAuthorize: Authorized as qian using PeerCred D [13/Jun/2012:10:40:59 -0700] cupsdIsAuthorized: username="qian" I [13/Jun/2012:10:40:59 -0700] Installing config file "/etc/cups/cupsd.conf"... D [13/Jun/2012:10:41:00 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:00 -0700] cupsdCloseClient: 17 D [13/Jun/2012:10:41:00 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:00 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:41:00 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [13/Jun/2012:10:41:00 -0700] Generating printcap /var/run/cups/printcap... I [13/Jun/2012:10:41:00 -0700] Saving subscriptions.conf... D [13/Jun/2012:10:41:00 -0700] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs and dirty files" I [13/Jun/2012:10:41:00 -0700] Remote access is disabled. D [13/Jun/2012:10:41:00 -0700] Added auto ServerAlias Stonau I [13/Jun/2012:10:41:00 -0700] Loaded configuration file "/etc/cups/cupsd.conf" I [13/Jun/2012:10:41:00 -0700] Using default TempDir of /var/spool/cups/tmp... I [13/Jun/2012:10:41:00 -0700] Configured for up to 100 clients. I [13/Jun/2012:10:41:00 -0700] Allowing up to 100 client connections per host. I [13/Jun/2012:10:41:00 -0700] Using policy "default" as the default. D [13/Jun/2012:10:41:00 -0700] load_ppd: Loading /var/cache/cups/HP-Deskjet-1050-J410-series.data... D [13/Jun/2012:10:41:00 -0700] Calling DeleteDevice(cups-HP-Deskjet-1050-J410-series) D [13/Jun/2012:10:41:00 -0700] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)' D [13/Jun/2012:10:41:00 -0700] Using profile id of HP-Deskjet-1050-J410-series-Gray.. D [13/Jun/2012:10:41:00 -0700] Calling CreateProfile(HP-Deskjet-1050-J410-series-Gray..,temp) W [13/Jun/2012:10:41:00 -0700] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'HP-Deskjet-1050-J410-series-Gray..' already exists D [13/Jun/2012:10:41:00 -0700] Using profile id of HP-Deskjet-1050-J410-series-RGB.. D [13/Jun/2012:10:41:00 -0700] Calling CreateProfile(HP-Deskjet-1050-J410-series-RGB..,temp) W [13/Jun/2012:10:41:00 -0700] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'HP-Deskjet-1050-J410-series-RGB..' already exists I [13/Jun/2012:10:41:00 -0700] Registering ICC color profiles for "HP-Deskjet-1050-J410-series" D [13/Jun/2012:10:41:00 -0700] Calling CreateDevice(cups-HP-Deskjet-1050-J410-series,temp) W [13/Jun/2012:10:41:00 -0700] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-HP-Deskjet-1050-J410-series' already exists D [13/Jun/2012:10:41:00 -0700] cupsdRegisterPrinter(p=0x208a0f18(HP-Deskjet-1050-J410-series)) D [13/Jun/2012:10:41:00 -0700] cupsdMarkDirty(---p--) D [13/Jun/2012:10:41:00 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs" I [13/Jun/2012:10:41:00 -0700] Partial reload complete. I [13/Jun/2012:10:41:00 -0700] Listening to [v1.::1]:631 on fd 9... I [13/Jun/2012:10:41:00 -0700] Listening to 127.0.0.1:631 on fd 10... I [13/Jun/2012:10:41:00 -0700] Listening to /var/run/cups/cups.sock:631 on fd 11... I [13/Jun/2012:10:41:00 -0700] Resuming new connection processing... D [13/Jun/2012:10:41:00 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:00 -0700] Notifier dbus started - PID = 15435 D [13/Jun/2012:10:41:00 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:41:00 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:00 -0700] PID 15419 (/usr/lib/cups/notifier/dbus) was terminated normally with signal 15. D [13/Jun/2012:10:41:00 -0700] [Notifier] state=3 D [13/Jun/2012:10:41:00 -0700] [Notifier] Connected to D-BUS D [13/Jun/2012:10:41:11 -0700] cupsdAcceptClient: 17 from localhost (Domain) D [13/Jun/2012:10:41:11 -0700] cupsdReadClient: 17 POST / HTTP/1.1 D [13/Jun/2012:10:41:11 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:11 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:11 -0700] cupsdReadClient: 17 1.1 Get-Notifications 1 D [13/Jun/2012:10:41:11 -0700] Get-Notifications / D [13/Jun/2012:10:41:11 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:41:11 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:41:11 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:11 -0700] cupsdReadClient: 17 WAITING Closing on EOF D [13/Jun/2012:10:41:11 -0700] cupsdCloseClient: 17 D [13/Jun/2012:10:41:11 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:25 -0700] cupsdAcceptClient: 17 from localhost (Domain) D [13/Jun/2012:10:41:25 -0700] cupsdReadClient: 17 POST / HTTP/1.1 D [13/Jun/2012:10:41:25 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:25 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:25 -0700] cupsdReadClient: 17 1.1 Get-Printer-Attributes 1 D [13/Jun/2012:10:41:25 -0700] Get-Printer-Attributes ipp://localhost/printers/HP-Deskjet-1050-J410-series D [13/Jun/2012:10:41:25 -0700] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/HP-Deskjet-1050-J410-series) from localhost D [13/Jun/2012:10:41:25 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" I [13/Jun/2012:10:41:31 -0700] Generating printcap /var/run/cups/printcap... I [13/Jun/2012:10:41:31 -0700] Saving subscriptions.conf... D [13/Jun/2012:10:41:31 -0700] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs" D [13/Jun/2012:10:41:39 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 1.1 Create-Printer-Subscription 1 D [13/Jun/2012:10:41:39 -0700] Create-Printer-Subscription / D [13/Jun/2012:10:41:39 -0700] cupsdCreateSubscription(con=0x208f6b00(19), uri="/") D [13/Jun/2012:10:41:39 -0700] pullmethod="ippget" D [13/Jun/2012:10:41:39 -0700] notify-lease-duration=86400 D [13/Jun/2012:10:41:39 -0700] notify-time-interval=0 D [13/Jun/2012:10:41:39 -0700] cupsdAddSubscription(mask=1798f, dest=(nil)(), job=(nil)(0), uri="(null)") D [13/Jun/2012:10:41:39 -0700] Added subscription #171 for server. D [13/Jun/2012:10:41:39 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and printing jobs" D [13/Jun/2012:10:41:39 -0700] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:41:39 -0700] CUPS-Get-Printers D [13/Jun/2012:10:41:39 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:41:39 -0700] CUPS-Get-Printers D [13/Jun/2012:10:41:39 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 21 1.1 Get-Printer-Attributes 1 D [13/Jun/2012:10:41:39 -0700] Get-Printer-Attributes ipp://localhost/printers/HP-Deskjet-1050-J410-series D [13/Jun/2012:10:41:39 -0700] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/HP-Deskjet-1050-J410-series) from localhost D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:41:39 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:41:39 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 1.1 Create-Printer-Subscription 1 D [13/Jun/2012:10:41:39 -0700] Create-Printer-Subscription / D [13/Jun/2012:10:41:39 -0700] cupsdCreateSubscription(con=0x208f6b00(19), uri="/") D [13/Jun/2012:10:41:39 -0700] pullmethod="ippget" D [13/Jun/2012:10:41:39 -0700] notify-lease-duration=86400 D [13/Jun/2012:10:41:39 -0700] notify-time-interval=0 D [13/Jun/2012:10:41:39 -0700] cupsdAddSubscription(mask=1798f, dest=(nil)(), job=(nil)(0), uri="(null)") D [13/Jun/2012:10:41:39 -0700] Added subscription #172 for server. D [13/Jun/2012:10:41:39 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:39 -0700] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:41:39 -0700] CUPS-Get-Printers D [13/Jun/2012:10:41:39 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:41:39 -0700] CUPS-Get-Printers D [13/Jun/2012:10:41:39 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:39 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:41:39 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:41:39 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 1.1 Get-Jobs 1 D [13/Jun/2012:10:41:40 -0700] Get-Jobs ipp://localhost/printers/ D [13/Jun/2012:10:41:40 -0700] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 21 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:41:40 -0700] Get-Job-Attributes ipp://localhost/jobs/152 D [13/Jun/2012:10:41:40 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/152) from localhost D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:41:40 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:41:40 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 1.1 Get-Jobs 1 D [13/Jun/2012:10:41:40 -0700] Get-Jobs ipp://localhost/printers/ D [13/Jun/2012:10:41:40 -0700] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:41:40 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 1.1 Get-Jobs 1 D [13/Jun/2012:10:41:40 -0700] Get-Jobs ipp://localhost/printers/ D [13/Jun/2012:10:41:40 -0700] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:41:40 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 1.1 Get-Jobs 1 D [13/Jun/2012:10:41:40 -0700] Get-Jobs ipp://localhost/printers/ D [13/Jun/2012:10:41:40 -0700] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:41:40 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 1.1 Get-Notifications 1 D [13/Jun/2012:10:41:40 -0700] Get-Notifications / D [13/Jun/2012:10:41:40 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:41:40 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:41:40 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 1.1 Get-Notifications 1 D [13/Jun/2012:10:41:40 -0700] Get-Notifications / D [13/Jun/2012:10:41:40 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:41:40 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:40 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:41:40 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:41:40 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:41 -0700] Report: clients=1 D [13/Jun/2012:10:41:41 -0700] Report: jobs=3 D [13/Jun/2012:10:41:41 -0700] Report: jobs-active=1 D [13/Jun/2012:10:41:41 -0700] Report: printers=1 D [13/Jun/2012:10:41:41 -0700] Report: printers-implicit=0 D [13/Jun/2012:10:41:41 -0700] Report: stringpool-string-count=4274 D [13/Jun/2012:10:41:41 -0700] Report: stringpool-alloc-bytes=11104 D [13/Jun/2012:10:41:41 -0700] Report: stringpool-total-bytes=85000 D [13/Jun/2012:10:41:45 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:41:45 -0700] cupsdReadClient: 19 POST /jobs/ HTTP/1.1 D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:45 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:45 -0700] cupsdReadClient: 19 1.1 Cancel-Job 1 D [13/Jun/2012:10:41:45 -0700] Cancel-Job ipp://localhost/jobs/152 D [13/Jun/2012:10:41:45 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:41:45 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" I [13/Jun/2012:10:41:45 -0700] [Job 152] Job canceled by "qian" D [13/Jun/2012:10:41:45 -0700] cupsdMarkDirty(----J-) D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" I [13/Jun/2012:10:41:45 -0700] [Job 152] Canceled by "qian". D [13/Jun/2012:10:41:45 -0700] Returning IPP successful-ok for Cancel-Job (ipp://localhost/jobs/152) from localhost D [13/Jun/2012:10:41:45 -0700] PID 15335 (/usr/lib/cups/filter/gstoraster) was terminated normally with signal 15. D [13/Jun/2012:10:41:45 -0700] [Notifier] state=3 D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:45 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:41:45 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:45 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:45 -0700] cupsdReadClient: 21 1.1 Get-Notifications 1 D [13/Jun/2012:10:41:45 -0700] Get-Notifications / D [13/Jun/2012:10:41:45 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:41:45 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:45 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:41:45 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:45 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:41:45 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:45 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:45 -0700] cupsdReadClient: 21 1.1 Get-Notifications 1 D [13/Jun/2012:10:41:45 -0700] Get-Notifications / D [13/Jun/2012:10:41:45 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:41:45 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:41:45 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:41:45 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:45 -0700] PID 15336 (/usr/lib/cups/filter/hpcups) exited with no errors. D [13/Jun/2012:10:41:45 -0700] [Job 152] prnt/backend/hp.c 839: ERROR: null print job total=0 D [13/Jun/2012:10:41:45 -0700] PID 15337 (/usr/lib/cups/backend/hp) exited with no errors. D [13/Jun/2012:10:41:45 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:41:45 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:45 -0700] [Notifier] state=3 D [13/Jun/2012:10:41:46 -0700] cupsdAcceptClient: 20 from localhost (Domain) D [13/Jun/2012:10:41:46 -0700] [Job 152] Unloading... D [13/Jun/2012:10:41:46 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 1.1 Get-Notifications 1 D [13/Jun/2012:10:41:46 -0700] Get-Notifications / D [13/Jun/2012:10:41:46 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:41:46 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 21 1.1 Get-Notifications 1 D [13/Jun/2012:10:41:46 -0700] Get-Notifications / D [13/Jun/2012:10:41:46 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:41:46 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 WAITING Closing on EOF D [13/Jun/2012:10:41:46 -0700] cupsdCloseClient: 20 D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdAcceptClient: 20 from localhost (Domain) D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 1.1 Get-Notifications 1 D [13/Jun/2012:10:41:46 -0700] Get-Notifications / D [13/Jun/2012:10:41:46 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:41:46 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:41:46 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 WAITING Closing on EOF D [13/Jun/2012:10:41:46 -0700] cupsdCloseClient: 20 D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdAcceptClient: 20 from localhost (Domain) D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:41:46 -0700] CUPS-Get-Printers D [13/Jun/2012:10:41:46 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Classes 1 D [13/Jun/2012:10:41:46 -0700] CUPS-Get-Classes D [13/Jun/2012:10:41:46 -0700] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Default 1 D [13/Jun/2012:10:41:46 -0700] CUPS-Get-Default D [13/Jun/2012:10:41:46 -0700] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:41:46 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:41:46 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:41:46 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:41:59 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:41:59 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:41:59 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:41:59 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:41:59 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:00 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:00 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:00 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 21 GET /printers/HP-Deskjet-1050-J410-series.ppd HTTP/1.1 D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:42:00 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:00 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:00 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:00 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:00 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:00 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:00 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 21 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:00 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:00 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:00 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:42:00 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:42:00 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:01 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:01 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:01 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:01 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:42:01 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:01 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:01 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:01 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:01 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:42:01 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:01 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:01 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:01 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:01 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:42:01 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:01 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:01 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:01 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:01 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:01 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:42:01 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:42:01 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:02 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:02 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:42:02 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:02 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:02 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:02 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:42:02 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:42:02 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:02 -0700] cupsdReadClient: 21 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:02 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:02 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:02 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:02 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:42:02 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:42:02 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:02 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:02 -0700] cupsdAcceptClient: 21 from localhost (Domain) D [13/Jun/2012:10:42:02 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:02 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:02 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:02 -0700] cupsdReadClient: 21 POST / HTTP/1.1 D [13/Jun/2012:10:42:02 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:42:02 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:02 -0700] cupsdReadClient: 21 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:02 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:02 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:02 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:02 -0700] cupsdReadClient: 21 WAITING Closing on EOF D [13/Jun/2012:10:42:02 -0700] cupsdCloseClient: 21 D [13/Jun/2012:10:42:02 -0700] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:06 -0700] cupsdReadClient: 19 POST /printers/HP-Deskjet-1050-J410-series HTTP/1.1 D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:06 -0700] cupsdReadClient: 19 1.1 Print-Job 1 D [13/Jun/2012:10:42:06 -0700] Print-Job ipp://localhost:631/printers/HP-Deskjet-1050-J410-series D [13/Jun/2012:10:42:06 -0700] [Job ???] Auto-typing file... I [13/Jun/2012:10:42:06 -0700] [Job ???] Request file type is application/pdf. D [13/Jun/2012:10:42:06 -0700] cupsdMarkDirty(----J-) D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:06 -0700] add_job: requesting-user-name="qian" I [13/Jun/2012:10:42:06 -0700] [Job 153] Adding start banner page "none". D [13/Jun/2012:10:42:06 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdMarkDirty(----J-) D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" I [13/Jun/2012:10:42:06 -0700] [Job 153] Adding end banner page "none". I [13/Jun/2012:10:42:06 -0700] [Job 153] File of type application/pdf queued by "qian". D [13/Jun/2012:10:42:06 -0700] [Job 153] hold_until=0 I [13/Jun/2012:10:42:06 -0700] [Job 153] Queued on "HP-Deskjet-1050-J410-series" by "qian". D [13/Jun/2012:10:42:06 -0700] cupsdMarkDirty(----J-) D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:06 -0700] [Job 153] job-sheets=none,none D [13/Jun/2012:10:42:06 -0700] [Job 153] argv[0]="HP-Deskjet-1050-J410-series" D [13/Jun/2012:10:42:06 -0700] [Job 153] argv[1]="153" D [13/Jun/2012:10:42:06 -0700] [Job 153] argv[2]="qian" D [13/Jun/2012:10:42:06 -0700] [Job 153] argv[3]="Gerantang_label.jpg" D [13/Jun/2012:10:42:06 -0700] [Job 153] argv[4]="1" D [13/Jun/2012:10:42:06 -0700] [Job 153] argv[5]="InputSlot=Auto number-up=1 PageSize=Custom.Custom.396.00x720.00 MediaType=Plain OutputMode=Best ColorModel=RGB job-uuid=urn:uuid:ca56ecae-ec4e-3296-7723-0c4263d1f1ac job-originating-host-name=localhost time-at-creation=1339609326 time-at-processing=1339609326" D [13/Jun/2012:10:42:06 -0700] [Job 153] argv[6]="/var/spool/cups/d00153-001" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[0]="CUPS_CACHEDIR=/var/cache/cups" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[1]="CUPS_DATADIR=/usr/share/cups" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[6]="CUPS_SERVERROOT=/etc/cups" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[7]="CUPS_STATEDIR=/var/run/cups" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[8]="HOME=/var/spool/cups/tmp" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[10]="SERVER_ADMIN=root@Stonau" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[11]="SOFTWARE=CUPS/1.5.3" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[12]="TMPDIR=/var/spool/cups/tmp" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[13]="USER=root" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[15]="CUPS_ENCRYPTION=IfRequested" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[16]="IPP_PORT=631" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[17]="CHARSET=utf-8" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[18]="LANG=en_US.UTF-8" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[19]="PPD=/etc/cups/ppd/HP-Deskjet-1050-J410-series.ppd" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[20]="RIP_MAX_CACHE=128m" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[21]="CONTENT_TYPE=application/pdf" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[22]="DEVICE_URI=hp:/usb/Deskjet_1050_J410_series?serial=CN22G3N0TQ05HW" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[23]="PRINTER_INFO=HP Deskjet 1050 J410 series" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[24]="PRINTER_LOCATION=Stonau" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[25]="PRINTER=HP-Deskjet-1050-J410-series" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[26]="PRINTER_STATE_REASONS=none" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[27]="CUPS_FILETYPE=document" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[28]="FINAL_CONTENT_TYPE=printer/HP-Deskjet-1050-J410-series" D [13/Jun/2012:10:42:06 -0700] [Job 153] envp[29]="AUTH_I****" I [13/Jun/2012:10:42:06 -0700] [Job 153] Started filter /usr/lib/cups/filter/pdftopdf (PID 15459) I [13/Jun/2012:10:42:06 -0700] [Job 153] Started filter /usr/lib/cups/filter/gstoraster (PID 15460) I [13/Jun/2012:10:42:06 -0700] [Job 153] Started filter /usr/lib/cups/filter/hpcups (PID 15461) I [13/Jun/2012:10:42:06 -0700] [Job 153] Started backend /usr/lib/cups/backend/hp (PID 15462) D [13/Jun/2012:10:42:06 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files" D [13/Jun/2012:10:42:06 -0700] Returning IPP successful-ok for Print-Job (ipp://localhost:631/printers/HP-Deskjet-1050-J410-series) from localhost D [13/Jun/2012:10:42:06 -0700] [Notifier] state=3 D [13/Jun/2012:10:42:06 -0700] [Notifier] state=3 D [13/Jun/2012:10:42:06 -0700] [Notifier] state=3 D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:06 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:06 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:06 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:06 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:06 -0700] cupsdReadClient: 19 1.1 Get-Notifications 1 D [13/Jun/2012:10:42:06 -0700] Get-Notifications / D [13/Jun/2012:10:42:06 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:42:06 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:42:06 -0700] cupsdReadClient: 22 1.1 Get-Notifications 1 D [13/Jun/2012:10:42:06 -0700] Get-Notifications / D [13/Jun/2012:10:42:06 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:42:06 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:06 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:06 -0700] cupsdReadClient: 19 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:06 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:06 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:06 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAcceptClient: 23 from localhost (Domain) D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:07 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 23 POST / HTTP/1.1 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 23 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:07 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:07 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:07 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:07 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 23 WAITING Closing on EOF D [13/Jun/2012:10:42:07 -0700] cupsdCloseClient: 23 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:07 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Classes 1 D [13/Jun/2012:10:42:07 -0700] CUPS-Get-Classes D [13/Jun/2012:10:42:07 -0700] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:07 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:07 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:07 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:07 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Default 1 D [13/Jun/2012:10:42:07 -0700] CUPS-Get-Default D [13/Jun/2012:10:42:07 -0700] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:07 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:07 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:07 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:07 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 19 1.1 Get-Notifications 1 D [13/Jun/2012:10:42:07 -0700] Get-Notifications / D [13/Jun/2012:10:42:07 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:42:07 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 19 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:07 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:07 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 1.1 Get-Printer-Attributes 1 D [13/Jun/2012:10:42:07 -0700] Get-Printer-Attributes D [13/Jun/2012:10:42:07 -0700] Get-Printer-Attributes client-error-not-found: The printer or class does not exist. D [13/Jun/2012:10:42:07 -0700] Returning IPP client-error-not-found for Get-Printer-Attributes () from localhost D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:07 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:07 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:07 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:07 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:07 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:07 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:07 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:07 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:07 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:07 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:08 -0700] [Job 153] PPD uses qualifier 'RGB.Plain.' D [13/Jun/2012:10:42:08 -0700] PID 15459 (/usr/lib/cups/filter/pdftopdf) exited with no errors. D [13/Jun/2012:10:42:08 -0700] [Job 153] Calling FindDeviceById(HP-Deskjet-1050-J410-series) D [13/Jun/2012:10:42:08 -0700] [Job 153] Failed to send: org.freedesktop.ColorManager.Failed:device id 'HP-Deskjet-1050-J410-series' does not exists D [13/Jun/2012:10:42:08 -0700] [Job 153] Failed to get profile filename! I [13/Jun/2012:10:42:08 -0700] [Job 153] no profiles specified in PPD D [13/Jun/2012:10:42:08 -0700] [Job 153] Set job-printer-state-message to "no profiles specified in PPD", current level=INFO D [13/Jun/2012:10:42:08 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:08 -0700] [Job 153] Ghostscript command line: /usr/bin/gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -sDEVICE=cups -sstdout=%stderr -sOutputFile=%stdout -sMediaType=Plain -sOutputType=1 -r600x600 -dMediaPosition=7 -dDEVICEWIDTHPOINTS=0 -dDEVICEHEIGHTPOINTS=0 -dcupsBitsPerColor=8 -dcupsColorOrder=0 -dcupsColorSpace=17 -scupsPageSizeName=Custom -I/usr/share/cups/fonts -c -f -_ D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[0]="CUPS_CACHEDIR=/var/cache/cups" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[1]="CUPS_DATADIR=/usr/share/cups" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[6]="CUPS_SERVERROOT=/etc/cups" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[7]="CUPS_STATEDIR=/var/run/cups" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[8]="HOME=/var/spool/cups/tmp" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[10]="SERVER_ADMIN=root@Stonau" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[11]="SOFTWARE=CUPS/1.5.3" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[12]="USER=root" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[13]="CUPS_SERVER=/var/run/cups/cups.sock" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[14]="CUPS_ENCRYPTION=IfRequested" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[15]="IPP_PORT=631" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[16]="CHARSET=utf-8" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[17]="LANG=en_US.UTF-8" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[18]="PPD=/etc/cups/ppd/HP-Deskjet-1050-J410-series.ppd" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[19]="RIP_MAX_CACHE=128m" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[20]="CONTENT_TYPE=application/pdf" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[21]="DEVICE_URI=hp:/usb/Deskjet_1050_J410_series?serial=CN22G3N0TQ05HW" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[22]="PRINTER_INFO=HP Deskjet 1050 J410 series" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[23]="PRINTER_LOCATION=Stonau" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[24]="PRINTER=HP-Deskjet-1050-J410-series" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[25]="PRINTER_STATE_REASONS=none" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[26]="CUPS_FILETYPE=document" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[27]="FINAL_CONTENT_TYPE=printer/HP-Deskjet-1050-J410-series" D [13/Jun/2012:10:42:08 -0700] [Job 153] envp[28]="AUTH_INFO_REQUIRED=none" D [13/Jun/2012:10:42:08 -0700] [Notifier] state=3 D [13/Jun/2012:10:42:08 -0700] [Notifier] state=3 D [13/Jun/2012:10:42:08 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:08 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 19 1.1 Get-Notifications 1 D [13/Jun/2012:10:42:08 -0700] Get-Notifications / D [13/Jun/2012:10:42:08 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:42:08 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 22 1.1 Get-Notifications 1 D [13/Jun/2012:10:42:08 -0700] Get-Notifications / D [13/Jun/2012:10:42:08 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:42:08 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdAcceptClient: 23 from localhost (Domain) D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:08 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 23 POST / HTTP/1.1 D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 23 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:08 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:08 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 23 WAITING Closing on EOF D [13/Jun/2012:10:42:08 -0700] cupsdCloseClient: 23 D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:08 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 19 1.1 Get-Notifications 1 D [13/Jun/2012:10:42:08 -0700] Get-Notifications / D [13/Jun/2012:10:42:08 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:42:08 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 22 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:08 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:08 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:08 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:08 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:08 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:08 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:09 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:42:09 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:09 -0700] cupsdAuthorize: No authentication data provided. I [13/Jun/2012:10:42:09 -0700] Saving job.cache... I [13/Jun/2012:10:42:09 -0700] Saving subscriptions.conf... D [13/Jun/2012:10:42:10 -0700] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:10 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:10 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:10 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:10 -0700] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs" D [13/Jun/2012:10:42:10 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:42:10 -0700] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs" D [13/Jun/2012:10:42:10 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:10 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Classes 1 D [13/Jun/2012:10:42:10 -0700] CUPS-Get-Classes D [13/Jun/2012:10:42:10 -0700] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost D [13/Jun/2012:10:42:10 -0700] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs" D [13/Jun/2012:10:42:10 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:42:10 -0700] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs" D [13/Jun/2012:10:42:10 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:10 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Default 1 D [13/Jun/2012:10:42:10 -0700] CUPS-Get-Default D [13/Jun/2012:10:42:10 -0700] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost D [13/Jun/2012:10:42:10 -0700] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs" I [13/Jun/2012:10:42:11 -0700] [Job 153] Start rendering... D [13/Jun/2012:10:42:11 -0700] [Job 153] Set job-printer-state-message to "Start rendering...", current level=INFO I [13/Jun/2012:10:42:11 -0700] [Job 153] Processing page 1... D [13/Jun/2012:10:42:11 -0700] [Job 153] Set job-printer-state-message to "Processing page 1...", current level=INFO D [13/Jun/2012:10:42:11 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:42:11 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs" D [13/Jun/2012:10:42:11 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:42:11 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:11 -0700] [Notifier] state=3 D [13/Jun/2012:10:42:11 -0700] [Notifier] state=3 D [13/Jun/2012:10:42:12 -0700] [Job 153] Unrecoverable error: rangecheck in setpagedevice D [13/Jun/2012:10:42:12 -0700] [Job 153] Operand stack: D [13/Jun/2012:10:42:12 -0700] [Job 153] true --nostringval-- --nostringval-- --nostringval-- --nostringval-- --nostringval-- --nostringval-- --nostringval-- --nostringval-- true --nostringval-- .LockSafetyParams true %MediaSource 0 %MediaDestination 0 LeadingEdge 0 --nostringval-- --nostringval-- --nostringval-- 0 --nostringval-- false --nostringval-- I [13/Jun/2012:10:42:12 -0700] [Job 153] Rendering completed D [13/Jun/2012:10:42:12 -0700] [Job 153] Set job-printer-state-message to "Rendering completed", current level=INFO D [13/Jun/2012:10:42:12 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdMarkDirty(-----S) D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] [Notifier] state=3 D [13/Jun/2012:10:42:12 -0700] [Notifier] state=3 D [13/Jun/2012:10:42:12 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 19 1.1 Get-Notifications 1 D [13/Jun/2012:10:42:12 -0700] Get-Notifications / D [13/Jun/2012:10:42:12 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:42:12 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:42:12 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 1.1 Get-Notifications 1 D [13/Jun/2012:10:42:12 -0700] Get-Notifications / D [13/Jun/2012:10:42:12 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:42:12 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAcceptClient: 23 from localhost (Domain) D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 23 POST / HTTP/1.1 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 23 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:12 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:12 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:12 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 23 WAITING Closing on EOF D [13/Jun/2012:10:42:12 -0700] cupsdCloseClient: 23 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:12 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:12 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:12 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:12 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAcceptClient: 19 from localhost (Domain) D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 19 POST / HTTP/1.1 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 19 1.1 Get-Notifications 1 D [13/Jun/2012:10:42:12 -0700] Get-Notifications / D [13/Jun/2012:10:42:12 -0700] cupsdIsAuthorized: requesting-user-name="qian" D [13/Jun/2012:10:42:12 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:12 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:12 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:12 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAcceptClient: 22 from localhost (Domain) D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 POST / HTTP/1.1 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 1.1 Get-Job-Attributes 1 D [13/Jun/2012:10:42:12 -0700] Get-Job-Attributes ipp://localhost/jobs/153 D [13/Jun/2012:10:42:12 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/153) from localhost D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 22 WAITING Closing on EOF D [13/Jun/2012:10:42:12 -0700] cupsdCloseClient: 22 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 19 WAITING Closing on EOF D [13/Jun/2012:10:42:12 -0700] cupsdCloseClient: 19 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Printers 1 D [13/Jun/2012:10:42:12 -0700] CUPS-Get-Printers D [13/Jun/2012:10:42:12 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Classes 1 D [13/Jun/2012:10:42:12 -0700] CUPS-Get-Classes D [13/Jun/2012:10:42:12 -0700] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 20 POST / HTTP/1.1 D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:12 -0700] cupsdAuthorize: No authentication data provided. D [13/Jun/2012:10:42:12 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Default 1 D [13/Jun/2012:10:42:12 -0700] CUPS-Get-Default D [13/Jun/2012:10:42:12 -0700] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost D [13/Jun/2012:10:42:12 -0700] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" I [13/Jun/2012:10:42:42 -0700] Saving subscriptions.conf... D [13/Jun/2012:10:42:42 -0700] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs and dirty files" D [13/Jun/2012:10:42:42 -0700] Report: clients=2 D [13/Jun/2012:10:42:42 -0700] Report: jobs=4 D [13/Jun/2012:10:42:42 -0700] Report: jobs-active=1 D [13/Jun/2012:10:42:42 -0700] Report: printers=1 D [13/Jun/2012:10:42:42 -0700] Report: printers-implicit=0 D [13/Jun/2012:10:42:42 -0700] Report: stringpool-string-count=7417 D [13/Jun/2012:10:42:42 -0700] Report: stringpool-alloc-bytes=11200 D [13/Jun/2012:10:42:42 -0700] Report: stringpool-total-bytes=155520