usr/lib/cups/backend/hp
David Oxland
doxland at shaw.ca
Fri May 25 17:48:39 PDT 2012
I have a problem using CUPS I believe which generates the following troubleshooting text.
Problem manifests itself as print jobs showing in the que for a few minutes then showing as completed with the above error.
Not sure where to go next Canonical Landscape are trying to help but no joy so far. Any pointers or advice from you would be much appreciated!
Thanks
David Oxland
Page 1 (Scheduler not running?):
{'cups_connection_failure': False}
Page 2 (Choose printer):
{'cups_dest': <cups.Dest HP-LaserJet-Pro-P1102w-2>,
'cups_instance': None,
'cups_queue': 'HP-LaserJet-Pro-P1102w-2',
'cups_queue_listed': True}
Page 3 (Check printer sanity):
{'cups_device_uri_scheme': u'hp',
'cups_printer_dict': {'device-uri': u'hp:/usb/HP_LaserJet_Professional_P1102wserial000000000Q93422TSI1c',
'printer-info': u'HP LaserJet Pro P1102w',
'printer-is-shared': True,
'printer-location': u'Desktop 2',
'printer-make-and-model': u'HP LaserJet Pro P1102w Foomatic/foo2zjs-z2 (recommended)',
'printer-state': 3,
'printer-state-message': u'/usr/lib/cups/backend/hp failed',
'printer-state-reasons': [u'none'],
'printer-type': 8425476,
'printer-uri-supported': u'ipp://localhost:631/printers/HP-LaserJet-Pro-P1102w-2'},
'cups_printer_remote': False,
'hplip_output': (['',
'\x1b[01mHP Linux Imaging and Printing System (ver. 3.12.4)\x1b[0m',
'\x1b[01mSystem Tray Status Service ver. 2.0\x1b[0m',
'',
'Copyright (c) 2001-9 Hewlett-Packard Development Company, LP',
'This software comes with ABSOLUTELY NO WARRANTY.',
'This is free software, and you are welcome to distribute it',
'under certain conditions. See COPYING file for more details.',
'',
'',
'\x1b[01mHP Linux Imaging and Printing System (ver. 3.12.4)\x1b[0m',
'\x1b[01mDevice Information Utility ver. 5.2\x1b[0m',
'',
'Copyright (c) 2001-9 Hewlett-Packard Development Company, LP',
'This software comes with ABSOLUTELY NO WARRANTY.',
'This is free software, and you are welcome to distribute it',
'under certain conditions. See COPYING file for more details.',
'',
'Using device: hp:/usb/HP_LaserJet_Professional_P1102w?serial=000000000Q93422TSI1c',
'',
'',
'\x1b[01mhp:/usb/HP_LaserJet_Professional_P1102w?serial=000000000Q93422TSI1c\x1b[0m',
'',
'\x1b[01mDevice Parameters (dynamic data):\x1b[0m',
'\x1b[01m Parameter Value(s) \x1b[0m',
' ---------------------------- ----------------------------------------------------------',
' back-end hp ',
" cups-printers ['HP-LaserJet-Pro-P1102w'] ",
' cups-uri hp:/usb/HP_LaserJet_Professional_P1102w?serial=000000000Q9',
' 3422TSI1c ',
' dev-file ',
' device-state -1 ',
' device-uri hp:/usb/HP_LaserJet_Professional_P1102w?serial=000000000Q9',
' 3422TSI1c ',
' deviceid ',
' error-state 101 ',
' host ',
' is-hp True ',
' panel 0 ',
' panel-line1 ',
' panel-line2 ',
' port 1 ',
' serial 000000000Q93422TSI1c ',
' status-code 5002 ',
' status-desc ',
'\x1b[01m',
'Model Parameters (static data):\x1b[0m',
'\x1b[01m Parameter Value(s) \x1b[0m',
' ---------------------------- ----------------------------------------------------------',
' align-type 0 ',
' clean-type 0 ',
' color-cal-type 0 ',
' copy-type 0 ',
' embedded-server-type 0 ',
' fax-type 0 ',
' fw-download True ',
' icon HP_LaserJet_1012.png ',
' io-mfp-mode 6 ',
' io-mode 1 ',
' io-support 10 ',
' job-storage 0 ',
' linefeed-cal-type 0 ',
' model HP_LaserJet_Professional_P1102w ',
' model-ui HP LaserJet Professional p1102w ',
' model1 HP LaserJet Professional P1102w Printer ',
' monitor-type 0 ',
' panel-check-type 0 ',
' pcard-type 0 ',
' plugin 1 ',
' plugin-reason 1 ',
' power-settings 0 ',
' pq-diag-type 0 ',
' r-type 0 ',
' r0-agent1-kind 4 ',
' r0-agent1-sku 35A ',
' r0-agent1-type 1 ',
' scan-style 0 ',
' scan-type 0 ',
' status-battery-check 0 ',
' status-dynamic-counters 0 ',
' status-type 8 ',
' support-released True ',
' support-subtype 2202411 ',
' support-type 2 ',
' support-ver 3.10.4 ',
" tech-class ['LJZjsMono'] ",
" tech-subclass ['NoAutoDuplex'] ",
' tech-type 3 ',
' usb-pid 810 ',
' usb-vid 1008 ',
' wifi-config 0 ',
'',
'Done.',
''],
['\x1b[35;01mwarning: No display found.\x1b[0m',
'\x1b[31;01merror: hp-info -u/--gui requires Qt4 GUI support. Entering interactive mode.\x1b[0m',
'\x1b[31;01merror: Invalid device URI: hp:/usb/HP_LaserJet_Professional_P1102wserial000000000Q93422TSI1c\x1b[0m',
'\x1b[35;01mwarning: No display found.\x1b[0m',
'\x1b[31;01merror: hp-systray requires Qt4 GUI and DBus support. Exiting.\x1b[0m',
'\x1b[35;01mwarning: Unable to connect to dbus. Is hp-systray running?\x1b[0m',
'\x1b[31;01merror: Unable to communicate with device (code=12): hp:/usb/HP_LaserJet_Professional_P1102w?serial=000000000Q93422TSI1c\x1b[0m',
'\x1b[31;01merror: Error opening device (Device not found).\x1b[0m',
''],
0),
'is_cups_class': False,
'local_cups_queue_attributes': {'auth-info-required': u'none',
'charset-configured': u'utf-8',
'charset-supported': [u'us-ascii', u'utf-8'],
'color-supported': False,
'compression-supported': [u'none', u'gzip'],
'copies-default': 1,
'copies-supported': (1, 9999),
'cups-version': u'1.4.6',
'device-uri': u'hp:/usb/HP_LaserJet_Professional_P1102wserial000000000Q93422TSI1c',
'document-format-default': u'application/octet-stream',
'document-format-supported': [u'application/octet-stream',
u'application/openofficeps',
u'application/pdf',
u'application/postscript',
u'application/vnd.adobe-reader-postscript',
u'application/vnd.cups-banner',
u'application/vnd.cups-command',
u'application/vnd.cups-pdf',
u'application/vnd.cups-postscript',
u'application/vnd.cups-raw',
u'application/vnd.hp-hpgl',
u'application/x-cshell',
u'application/x-csource',
u'application/x-perl',
u'application/x-shell',
u'image/gif',
u'image/jpeg',
u'image/png',
u'image/tiff',
u'image/x-bitmap',
u'image/x-photocd',
u'image/x-portable-anymap',
u'image/x-portable-bitmap',
u'image/x-portable-graymap',
u'image/x-portable-pixmap',
u'image/x-sgi-rgb',
u'image/x-sun-raster',
u'image/x-xbitmap',
u'image/x-xpixmap',
u'image/x-xwindowdump',
u'text/css',
u'text/html',
u'text/plain'],
'finishings-default': 3,
'finishings-supported': [3],
'generated-natural-language-supported': [u'en-us'],
'ipp-versions-supported': [u'1.0',
u'1.1',
u'2.0',
u'2.1'],
'ippget-event-life': 15,
'job-creation-attributes-supported': [u'copies',
u'finishings',
u'ipp-attribute-fidelity',
u'job-hold-until',
u'job-name',
u'job-priority',
u'job-sheets',
u'media',
u'media-col',
u'multiple-document-handling',
u'number-up',
u'output-bin',
u'output-mode',
u'orientation-requested',
u'page-ranges',
u'print-quality',
u'printer-resolution',
u'sides'],
'job-hold-until-default': u'no-hold',
'job-hold-until-supported': [u'no-hold',
u'indefinite',
u'day-time',
u'evening',
u'night',
u'second-shift',
u'third-shift',
u'weekend'],
'job-k-limit': 0,
'job-page-limit': 0,
'job-priority-default': 50,
'job-priority-supported': [100],
'job-quota-period': 0,
'job-settable-attributes-supported': [u'copies',
u'finishings',
u'job-hold-until',
u'job-name',
u'job-priority',
u'media',
u'media-col',
u'multiple-document-handling',
u'number-up',
u'output-bin',
u'output-mode',
u'orientation-requested',
u'page-ranges',
u'print-quality',
u'printer-resolution',
u'sides'],
'job-sheets-default': (u'none', u'none'),
'job-sheets-supported': [u'none',
u'classified',
u'confidential',
u'secret',
u'standard',
u'topsecret',
u'unclassified'],
'marker-change-time': 0,
'media-bottom-margin-supported': [400],
'media-col-supported': [u'media-bottom-margin',
u'media-left-margin',
u'media-right-margin',
u'media-size',
u'media-source',
u'media-top-margin',
u'media-type'],
'media-default': u'na_letter_8.5x11in',
'media-left-margin-supported': [400],
'media-right-margin-supported': [400],
'media-source-supported': [u'top',
u'middle',
u'bottom',
u'auto',
u'envelope',
u'manual'],
'media-supported': [u'na_letter_8.5x11in',
u'iso_a4_210x297mm',
u'iso_a5_148x210mm',
u'iso_a6_105x148mm',
u'jis_b5_182x257mm',
u'jpn_hagaki_100x148mm',
u'na_number-10_4.125x9.5in',
u'iso_c5_162x229mm',
u'iso_dl_110x220mm',
u'na_monarch_3.875x7.5in',
u'na_executive_7.25x10.5in',
u'na_legal_8.5x14in',
u'om_w522h737_184.15x259.99mm',
u'om_w553h765_195.08x269.87mm',
u'oe_w558h774_7.75x10.75in',
u'custom_min_0.5x0.5in',
u'custom_max_35277.770000x35277.770000mm'],
'media-top-margin-supported': [400],
'media-type-supported': [u'bond',
u'color',
u'envelope',
u'extra-heavy',
u'heavy',
u'labels',
u'stationery-letterhead',
u'light',
u'medium',
u'stationery-preprinted',
u'prepunched',
u'recycled',
u'rough',
u'standard',
u'thick-stock',
u'transparency',
u'vellum'],
'multiple-document-handling-supported': [u'separate-documents-uncollated-copies',
u'separate-documents-collated-copies'],
'multiple-document-jobs-supported': True,
'multiple-operation-time-out': 300,
'natural-language-configured': u'en-us',
'notify-attributes-supported': [u'printer-state-change-time',
u'notify-lease-expiration-time',
u'notify-subscriber-user-name'],
'notify-events-default': [u'job-completed'],
'notify-events-supported': [u'job-completed',
u'job-config-changed',
u'job-created',
u'job-progress',
u'job-state-changed',
u'job-stopped',
u'printer-added',
u'printer-changed',
u'printer-config-changed',
u'printer-deleted',
u'printer-finishings-changed',
u'printer-media-changed',
u'printer-modified',
u'printer-restarted',
u'printer-shutdown',
u'printer-state-changed',
u'printer-stopped',
u'server-audit',
u'server-restarted',
u'server-started',
u'server-stopped'],
'notify-lease-duration-default': 86400,
'notify-lease-duration-supported': (0,
2147483647),
'notify-max-events-supported': [100],
'notify-pull-method-supported': [u'ippget'],
'notify-schemes-supported': [u'dbus',
u'mailto',
u'rss'],
'number-up-default': 1,
'number-up-supported': [1, 2, 4, 6, 9, 16],
'operations-supported': [2,
4,
5,
6,
8,
9,
10,
11,
12,
13,
16,
17,
18,
19,
20,
21,
22,
23,
24,
25,
26,
27,
28,
34,
35,
37,
38,
16385,
16386,
16387,
16388,
16389,
16390,
16391,
16392,
16393,
16394,
16395,
16396,
16397,
16398,
16399,
16423],
'orientation-requested-default': None,
'orientation-requested-supported': [3,
4,
5,
6],
'output-bin-default': u'face-down',
'output-bin-supported': [u'face-down'],
'output-mode-default': u'monochrome',
'output-mode-supported': [u'monochrome'],
'page-ranges-supported': True,
'pages-per-minute': 1,
'pdl-override-supported': [u'attempted'],
'port-monitor': u'none',
'port-monitor-supported': [u'none'],
'print-quality-default': 4,
'print-quality-supported': [4],
'printer-commands': [u'AutoConfigure',
u'Clean',
u'PrintSelfTestPage'],
'printer-current-time': '(IPP_TAG_DATE)',
'printer-dns-sd-name': u'HP LaserJet Pro P1102w @ david-desktop',
'printer-error-policy': u'retry-job',
'printer-error-policy-supported': [u'abort-job',
u'retry-current-job',
u'retry-job',
u'stop-printer'],
'printer-icons': u'http://localhost:631/icons/HP-LaserJet-Pro-P1102w-2.png',
'printer-info': u'HP LaserJet Pro P1102w',
'printer-is-accepting-jobs': True,
'printer-is-shared': True,
'printer-location': u'Desktop 2',
'printer-make-and-model': u'HP LaserJet Pro P1102w Foomatic/foo2zjs-z2 (recommended)',
'printer-more-info': u'http://localhost:631/printers/HP-LaserJet-Pro-P1102w-2',
'printer-name': u'HP-LaserJet-Pro-P1102w-2',
'printer-op-policy': u'default',
'printer-op-policy-supported': [u'authenticated',
u'default'],
'printer-resolution-default': '(unknown IPP tag)',
'printer-resolution-supported': '(unknown IPP tag)',
'printer-settable-attributes-supported': [u'printer-info',
u'printer-location'],
'printer-state': 3,
'printer-state-change-time': 1337991851,
'printer-state-message': u'/usr/lib/cups/backend/hp failed',
'printer-state-reasons': [u'none'],
'printer-type': 8425476,
'printer-up-time': 1337991921,
'printer-uri-supported': [u'ipp://localhost:631/printers/HP-LaserJet-Pro-P1102w-2'],
'queued-job-count': 3,
'server-is-sharing-printers': True,
'sides-default': u'one-sided',
'sides-supported': [u'one-sided'],
'uri-authentication-supported': [u'requesting-user-name'],
'uri-security-supported': [u'none']}}
Page 4 (Check PPD sanity):
{'cups_printer_ppd_defaults': {u'Adjustment': {u'halftone': u'default'},
u'General': {u'Copies': u'1',
u'Density': u'Density3',
u'InputSlot': u'Auto',
u'MediaType': u'Standard',
u'PageRegion': u'Letter',
u'PageSize': u'Letter',
u'Quality': u'normal'},
u'Miscellaneous': {u'NupOrient': u'port',
u'NupPages': u'1up'}},
'cups_printer_ppd_valid': True,
'missing_pkgs_and_exes': ([], [])}
Page 5 (Local or remote?):
{'printer_is_remote': False}
Page 6 (Error log checkpoint):
{'cups_server_settings': {'BrowseLocalProtocols': 'CUPS dnssd',
'BrowseRemoteProtocols': 'CUPS dnssd',
'DefaultAuthType': 'Basic',
'LogLevel': 'debug',
'MaxLogSize': '0',
'Port': '631',
'SystemGroup': 'lpadmin',
'_debug_logging': '1',
'_remote_admin': '1',
'_remote_any': '0',
'_remote_printers': '1',
'_share_printers': '1',
'_user_cancel_any': '0'},
'error_log_checkpoint': 705650}
Page 7 (Print test page):
{'test_page_attempted': '25/May/2012:17:26:05 +0000',
'test_page_job_id': [168],
'test_page_job_status': [(True,
168,
'HP-LaserJet-Pro-P1102w-2',
'Test Page',
'Held',
{'attributes-charset': u'utf-8',
'attributes-natural-language': u'en-ca',
'document-count': 1,
'document-format': u'application/vnd.cups-banner',
'job-hold-until': u'0:31:6',
'job-id': 168,
'job-k-octets': 1,
'job-media-progress': 0,
'job-media-sheets-completed': 1,
'job-more-info': u'ipp://localhost:631/jobs/168',
'job-name': u'Test Page',
'job-originating-host-name': u'localhost',
'job-originating-user-name': u'david',
'job-printer-state-message': u'/usr/lib/cups/backend/hp failed',
'job-printer-state-reasons': [u'none'],
'job-printer-up-time': 1337991978,
'job-printer-uri': u'ipp://david-desktop:631/printers/HP-LaserJet-Pro-P1102w-2',
'job-priority': 50,
'job-sheets': [u'none', u'none'],
'job-state': 4,
'job-state-reasons': u'job-hold-until-specified',
'job-uri': u'ipp://localhost:631/jobs/168',
'job-uuid': u'urn:uuid:7af7b623-5ae3-378c-510f-808976312709',
'printer-uri': u'ipp://localhost/printers/HP-LaserJet-Pro-P1102w-2',
'time-at-completed': None,
'time-at-creation': 1337991965,
'time-at-processing': 1337991965}),
(False,
164,
'HP-LaserJet-Pro-P1102w-2',
'Test Page',
'Held',
None),
(False,
165,
'HP-LaserJet-Pro-P1102w-2',
'Test Page',
'Held',
None),
(False,
166,
'HP-LaserJet-Pro-P1102w-2',
'Test Page',
'Held',
None)],
'test_page_successful': False}
Page 8 (Error log fetch):
{'error_log': ['D [25/May/2012:17:25:41 -0700] cupsdSetBusyState: Not busy',
'D [25/May/2012:17:25:41 -0700] cupsdReadClient: 34 POST / HTTP/1.1',
'D [25/May/2012:17:25:41 -0700] cupsdSetBusyState: Active clients',
'D [25/May/2012:17:25:41 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:25:41 -0700] cupsdReadClient: 34 1.1 Get-Jobs 1',
'D [25/May/2012:17:25:41 -0700] Get-Jobs ipp://localhost/printers/',
'D [25/May/2012:17:25:41 -0700] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost',
'D [25/May/2012:17:25:41 -0700] cupsdSetBusyState: Not busy',
'D [25/May/2012:17:25:41 -0700] cupsdReadClient: 34 POST / HTTP/1.1',
'D [25/May/2012:17:25:41 -0700] cupsdSetBusyState: Active clients',
'D [25/May/2012:17:25:41 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:25:41 -0700] cupsdReadClient: 34 1.1 Get-Jobs 1',
'D [25/May/2012:17:25:41 -0700] Get-Jobs ipp://localhost/printers/',
'D [25/May/2012:17:25:41 -0700] [Job 142] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 143] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 144] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 145] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 146] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 147] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 148] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 149] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 150] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 151] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 152] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 153] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 154] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 155] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 156] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 157] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 158] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 159] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 160] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 161] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] [Job 162] Loading attributes...',
'D [25/May/2012:17:25:41 -0700] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost',
'D [25/May/2012:17:25:41 -0700] cupsdSetBusyState: Not busy',
'D [25/May/2012:17:25:41 -0700] cupsdReadClient: 34 POST / HTTP/1.1',
'D [25/May/2012:17:25:41 -0700] cupsdSetBusyState: Active clients',
'D [25/May/2012:17:25:41 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:25:41 -0700] cupsdReadClient: 34 1.1 Create-Printer-Subscription 1',
'D [25/May/2012:17:25:41 -0700] Create-Printer-Subscription /',
'D [25/May/2012:17:25:41 -0700] cupsdCreateSubscription(con=0x7fc891e70930(34), uri="/")',
'D [25/May/2012:17:25:41 -0700] pullmethod="ippget"',
'D [25/May/2012:17:25:41 -0700] notify-lease-duration=86400',
'D [25/May/2012:17:25:41 -0700] notify-time-interval=0',
'D [25/May/2012:17:25:41 -0700] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")',
'D [25/May/2012:17:25:41 -0700] Added subscription 219 for server',
'D [25/May/2012:17:25:41 -0700] cupsdMarkDirty(-----S)',
'D [25/May/2012:17:25:41 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:25:41 -0700] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost',
'D [25/May/2012:17:25:41 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:25:42 -0700] cupsdReadClient: 34 POST / HTTP/1.1',
'D [25/May/2012:17:25:42 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:25:42 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:25:42 -0700] cupsdReadClient: 34 1.1 Get-Notifications 1',
'D [25/May/2012:17:25:42 -0700] Get-Notifications /',
'D [25/May/2012:17:25:42 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:25:42 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost',
'D [25/May/2012:17:25:42 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:25:43 -0700] Report: clients=19',
'D [25/May/2012:17:25:43 -0700] Report: jobs=26',
'D [25/May/2012:17:25:43 -0700] Report: jobs-active=5',
'D [25/May/2012:17:25:43 -0700] Report: printers=2',
'D [25/May/2012:17:25:43 -0700] Report: printers-implicit=0',
'D [25/May/2012:17:25:43 -0700] Report: stringpool-string-count=37957',
'D [25/May/2012:17:25:43 -0700] Report: stringpool-alloc-bytes=13416',
'D [25/May/2012:17:25:43 -0700] Report: stringpool-total-bytes=703304',
'D [25/May/2012:17:25:45 -0700] cupsdNetIFUpdate: "lo" = localhost:631',
'D [25/May/2012:17:25:45 -0700] cupsdNetIFUpdate: "eth0" = 192.168.0.100:631',
'D [25/May/2012:17:25:45 -0700] cupsdNetIFUpdate: "lo" = localhost:631',
'D [25/May/2012:17:25:45 -0700] cupsdNetIFUpdate: "eth0" = [v1.fe80::224:8cff:fe73:e401+eth0]:631',
'D [25/May/2012:17:25:49 -0700] Closing client 15 after 300 seconds of inactivity...',
'D [25/May/2012:17:25:49 -0700] cupsdCloseClient: 15',
'D [25/May/2012:17:26:05 -0700] cupsdAcceptClient: 15 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 15 POST /printers/HP-LaserJet-Pro-P1102w-2 HTTP/1.1',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 15 1.1 Print-Job 1',
'D [25/May/2012:17:26:05 -0700] Print-Job ipp://localhost/printers/HP-LaserJet-Pro-P1102w-2',
'D [25/May/2012:17:26:05 -0700] [Job ???] Auto-typing file...',
'I [25/May/2012:17:26:05 -0700] [Job ???] Request file type is application/vnd.cups-banner.',
'D [25/May/2012:17:26:05 -0700] cupsdMarkDirty(----J-)',
'D [25/May/2012:17:26:05 -0700] add_job: requesting-user-name="david"',
'D [25/May/2012:17:26:05 -0700] Adding default job-sheets values "none,none"...',
'I [25/May/2012:17:26:05 -0700] [Job 168] Adding start banner page "none".',
'D [25/May/2012:17:26:05 -0700] cupsdMarkDirty(-----S)',
'D [25/May/2012:17:26:05 -0700] cupsdMarkDirty(----J-)',
'I [25/May/2012:17:26:05 -0700] [Job 168] Adding end banner page "none".',
'I [25/May/2012:17:26:05 -0700] [Job 168] File of type application/vnd.cups-banner queued by "david".',
'D [25/May/2012:17:26:05 -0700] [Job 168] hold_until=0',
'I [25/May/2012:17:26:05 -0700] [Job 168] Queued on "HP-LaserJet-Pro-P1102w-2" by "david".',
'D [25/May/2012:17:26:05 -0700] cupsdMarkDirty(----J-)',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Active clients, printing jobs, and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdMarkDirty(-----S)',
'D [25/May/2012:17:26:05 -0700] [Job 168] job-sheets=none,none',
'D [25/May/2012:17:26:05 -0700] [Job 168] argv[0]="HP-LaserJet-Pro-P1102w-2"',
'D [25/May/2012:17:26:05 -0700] [Job 168] argv[1]="168"',
'D [25/May/2012:17:26:05 -0700] [Job 168] argv[2]="david"',
'D [25/May/2012:17:26:05 -0700] [Job 168] argv[3]="Test Page"',
'D [25/May/2012:17:26:05 -0700] [Job 168] argv[4]="1"',
'D [25/May/2012:17:26:05 -0700] [Job 168] argv[5]="job-uuid=urn:uuid:7af7b623-5ae3-378c-510f-808976312709 job-originating-host-name=localhost time-at-creation=1337991965 time-at-processing=1337991965 AP_D_InputSlot="',
'D [25/May/2012:17:26:05 -0700] [Job 168] argv[6]="/var/spool/cups/d00168-001"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[0]="CUPS_CACHEDIR=/var/cache/cups"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[1]="CUPS_DATADIR=/usr/share/cups"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[6]="CUPS_SERVERROOT=/etc/cups"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[7]="CUPS_STATEDIR=/var/run/cups"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[8]="HOME=/var/spool/cups/tmp"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[10]="SERVER_ADMIN=root at david-desktop"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[11]="SOFTWARE=CUPS/1.4.6"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[12]="TMPDIR=/var/spool/cups/tmp"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[13]="USER=root"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[14]="CUPS_SERVER=localhost"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[15]="CUPS_ENCRYPTION=IfRequested"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[16]="IPP_PORT=631"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[17]="CHARSET=utf-8"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[18]="LANG=en_CA.UTF-8"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[19]="PPD=/etc/cups/ppd/HP-LaserJet-Pro-P1102w-2.ppd"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[20]="RIP_MAX_CACHE=auto"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[21]="CONTENT_TYPE=application/vnd.cups-banner"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[22]="DEVICE_URI=hp:/usb/HP_LaserJet_Professional_P1102wserial000000000Q93422TSI1c"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[23]="PRINTER_INFO=HP LaserJet Pro P1102w"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[24]="PRINTER_LOCATION=Desktop 2"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[25]="PRINTER=HP-LaserJet-Pro-P1102w-2"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[26]="CUPS_FILETYPE=document"',
'D [25/May/2012:17:26:05 -0700] [Job 168] envp[27]="FINAL_CONTENT_TYPE=printer/HP-LaserJet-Pro-P1102w-2"',
'I [25/May/2012:17:26:05 -0700] [Job 168] Started filter /usr/lib/cups/filter/bannertops (PID 6473)',
'I [25/May/2012:17:26:05 -0700] [Job 168] Started filter /usr/lib/cups/filter/pstopdf (PID 6474)',
'I [25/May/2012:17:26:05 -0700] [Job 168] Started filter /usr/lib/cups/filter/pdftopdf (PID 6475)',
'I [25/May/2012:17:26:05 -0700] [Job 168] Started filter /usr/lib/cups/filter/foomatic-rip (PID 6476)',
'I [25/May/2012:17:26:05 -0700] [Job 168] Started backend /usr/lib/cups/backend/hp (PID 6478)',
'D [25/May/2012:17:26:05 -0700] cupsdMarkDirty(-----S)',
'D [25/May/2012:17:26:05 -0700] Returning IPP successful-ok for Print-Job (ipp://localhost/printers/HP-LaserJet-Pro-P1102w-2) from localhost',
'D [25/May/2012:17:26:05 -0700] [Job 168] pstopdf 5 args: 168 david Test Page 1 job-uuid=urn:uuid:7af7b623-5ae3-378c-510f-808976312709 job-originating-host-name=localhost time-at-creation=1337991965 time-at-processing=1337991965 AP_D_InputSlot=',
'D [25/May/2012:17:26:05 -0700] [Job 168] PPD: /etc/cups/ppd/HP-LaserJet-Pro-P1102w-2.ppd',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Printing jobs and dirty files',
'D [25/May/2012:17:26:05 -0700] [Job 168] Getting input from file',
'D [25/May/2012:17:26:05 -0700] [Job 168] foomatic-rip version 4.0.7.235 running...',
'D [25/May/2012:17:26:05 -0700] [Job 168] Parsing PPD file ...',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option PageSize',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option Quality',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option Resolution',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option ImageableArea',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option PaperDimension',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option InputSlot',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option MediaType',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option Density',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option Copies',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option halftone',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option NupOrient',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option NupPages',
'D [25/May/2012:17:26:05 -0700] [Job 168] Added option Font',
'D [25/May/2012:17:26:05 -0700] [Job 168]',
'D [25/May/2012:17:26:05 -0700] [Job 168] Parameter Summary',
'D [25/May/2012:17:26:05 -0700] [Job 168] -----------------',
'D [25/May/2012:17:26:05 -0700] [Job 168]',
'D [25/May/2012:17:26:05 -0700] [Job 168] Spooler: cups',
'D [25/May/2012:17:26:05 -0700] [Job 168] Printer: HP-LaserJet-Pro-P1102w-2',
'D [25/May/2012:17:26:05 -0700] [Job 168] Shell: /bin/bash',
'D [25/May/2012:17:26:05 -0700] [Job 168] PPD file: /etc/cups/ppd/HP-LaserJet-Pro-P1102w-2.ppd',
'D [25/May/2012:17:26:05 -0700] [Job 168] ATTR file:',
'D [25/May/2012:17:26:05 -0700] [Job 168] Printer model: HP LaserJet Pro P1102w Foomatic/foo2zjs-z2 (recommended)',
'D [25/May/2012:17:26:05 -0700] [Job 168] Job title: Test Page',
'D [25/May/2012:17:26:05 -0700] [Job 168] File(s) to be printed:',
'D [25/May/2012:17:26:05 -0700] [Job 168] <STDIN>',
'D [25/May/2012:17:26:05 -0700] [Job 168]',
"D [25/May/2012:17:26:05 -0700] [Job 168] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts",
'D [25/May/2012:17:26:05 -0700] [Job 168] Printing system options:',
"D [25/May/2012:17:26:05 -0700] [Job 168] Pondering option 'job-uuid=urn:uuid:7af7b623-5ae3-378c-510f-808976312709'",
'D [25/May/2012:17:26:05 -0700] [Job 168] Unknown option job-uuid=urn:uuid:7af7b623-5ae3-378c-510f-808976312709.',
"D [25/May/2012:17:26:05 -0700] [Job 168] Pondering option 'job-originating-host-name=localhost'",
'D [25/May/2012:17:26:05 -0700] [Job 168] Unknown option job-originating-host-name=localhost.',
"D [25/May/2012:17:26:05 -0700] [Job 168] Pondering option 'time-at-creation=1337991965'",
'D [25/May/2012:17:26:05 -0700] [Job 168] Unknown option time-at-creation=1337991965.',
"D [25/May/2012:17:26:05 -0700] [Job 168] Pondering option 'time-at-processing=1337991965'",
'D [25/May/2012:17:26:05 -0700] [Job 168] Unknown option time-at-processing=1337991965.',
"D [25/May/2012:17:26:05 -0700] [Job 168] Pondering option 'AP_D_InputSlot='",
'D [25/May/2012:17:26:05 -0700] [Job 168] Unknown option AP_D_InputSlot=.',
'D [25/May/2012:17:26:05 -0700] [Job 168] Options from the PPD file:',
'D [25/May/2012:17:26:05 -0700] [Job 168]',
'D [25/May/2012:17:26:05 -0700] [Job 168] ================================================',
'D [25/May/2012:17:26:05 -0700] [Job 168]',
'D [25/May/2012:17:26:05 -0700] [Job 168] File: <STDIN>',
'D [25/May/2012:17:26:05 -0700] [Job 168]',
'D [25/May/2012:17:26:05 -0700] [Job 168] ================================================',
'D [25/May/2012:17:26:05 -0700] [Job 168]',
'D [25/May/2012:17:26:05 -0700] [Job 168] load_banner(filename="/var/spool/cups/d00168-001")',
'D [25/May/2012:17:26:05 -0700] [Job 168] Page = 612x792; 11,11 to 601,781',
'D [25/May/2012:17:26:05 -0700] [Job 168] PNG image: 128x128x8, color_type=6 (RGB+ALPHA)',
'D [25/May/2012:17:26:05 -0700] [Job 168] PNG image: 192x128x8, color_type=2 (RGB)',
'D [25/May/2012:17:26:05 -0700] PID 6473 (/usr/lib/cups/filter/bannertops) exited with no errors.',
'D [25/May/2012:17:26:05 -0700] [Job 168] Resolution:',
'D [25/May/2012:17:26:05 -0700] [Job 168] Page size: Letter',
'D [25/May/2012:17:26:05 -0700] [Job 168] Width: 612, height: 792, absolute margins: 11.34, 11.34, 600.66, 780.66',
'D [25/May/2012:17:26:05 -0700] [Job 168] Relative margins: 11.34, 11.34, 11.34, 11.34',
'D [25/May/2012:17:26:05 -0700] [Job 168] PPD options: -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792',
'D [25/May/2012:17:26:05 -0700] [Job 168] PostScript to be injected:',
'D [25/May/2012:17:26:05 -0700] [Job 168] Running cat | /usr/bin/gs -q -dNOPAUSE -dBATCH -sDEVICE=pdfwrite -dCompatibilityLevel=1.3 -dAutoRotatePages=/None -dAutoFilterColorImages=false -dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr -dColorImageFilter=/FlateEncode -dPDFSETTINGS=/printer -dColorConversionStrategy=/LeaveColorUnchanged -dDoNumCopies -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -sOutputFile=- -c .setpdfwrite -f -',
'D [25/May/2012:17:26:05 -0700] cupsdAcceptClient: 36 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 36 POST / HTTP/1.1',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Active clients, printing jobs, and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:05 -0700] cupsdAcceptClient: 37 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 POST / HTTP/1.1',
'D [25/May/2012:17:26:05 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 36 1.1 Get-Notifications 1',
'D [25/May/2012:17:26:05 -0700] Get-Notifications /',
'D [25/May/2012:17:26:05 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:26:05 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 1.1 Get-Notifications 1',
'D [25/May/2012:17:26:05 -0700] Get-Notifications /',
'D [25/May/2012:17:26:05 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:26:05 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 WAITING Closing on EOF',
'D [25/May/2012:17:26:05 -0700] cupsdCloseClient: 37',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 34 POST / HTTP/1.1',
'D [25/May/2012:17:26:05 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 34 1.1 Get-Notifications 1',
'D [25/May/2012:17:26:05 -0700] Get-Notifications /',
'D [25/May/2012:17:26:05 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:26:05 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 36 POST / HTTP/1.1',
'D [25/May/2012:17:26:05 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 36 1.1 Get-Job-Attributes 1',
'D [25/May/2012:17:26:05 -0700] Get-Job-Attributes ipp://localhost/jobs/168',
'D [25/May/2012:17:26:05 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/168) from localhost',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Printing jobs and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdAcceptClient: 37 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 POST / HTTP/1.1',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Active clients, printing jobs, and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 1.1 Get-Job-Attributes 1',
'D [25/May/2012:17:26:05 -0700] Get-Job-Attributes ipp://localhost/jobs/168',
'D [25/May/2012:17:26:05 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/168) from localhost',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Printing jobs and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 WAITING Closing on EOF',
'D [25/May/2012:17:26:05 -0700] cupsdCloseClient: 37',
'D [25/May/2012:17:26:05 -0700] cupsdAcceptClient: 37 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 POST / HTTP/1.1',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Active clients, printing jobs, and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 1.1 Get-Job-Attributes 1',
'D [25/May/2012:17:26:05 -0700] Get-Job-Attributes ipp://localhost/jobs/168',
'D [25/May/2012:17:26:05 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/168) from localhost',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Printing jobs and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 WAITING Closing on EOF',
'D [25/May/2012:17:26:05 -0700] cupsdCloseClient: 37',
'D [25/May/2012:17:26:05 -0700] cupsdAcceptClient: 37 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 POST / HTTP/1.1',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Active clients, printing jobs, and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 1.1 Get-Job-Attributes 1',
'D [25/May/2012:17:26:05 -0700] Get-Job-Attributes ipp://localhost/jobs/168',
'D [25/May/2012:17:26:05 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/168) from localhost',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Printing jobs and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 37 WAITING Closing on EOF',
'D [25/May/2012:17:26:05 -0700] cupsdCloseClient: 37',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 36 WAITING Closing on EOF',
'D [25/May/2012:17:26:05 -0700] cupsdCloseClient: 36',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 20 POST / HTTP/1.1',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Active clients, printing jobs, and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Printers 1',
'D [25/May/2012:17:26:05 -0700] CUPS-Get-Printers',
'D [25/May/2012:17:26:05 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Printing jobs and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 20 POST / HTTP/1.1',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Active clients, printing jobs, and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Classes 1',
'D [25/May/2012:17:26:05 -0700] CUPS-Get-Classes',
'D [25/May/2012:17:26:05 -0700] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Printing jobs and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 20 POST / HTTP/1.1',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Active clients, printing jobs, and dirty files',
'D [25/May/2012:17:26:05 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:05 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Default 1',
'D [25/May/2012:17:26:05 -0700] CUPS-Get-Default',
'D [25/May/2012:17:26:05 -0700] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
'D [25/May/2012:17:26:05 -0700] cupsdSetBusyState: Printing jobs and dirty files',
'D [25/May/2012:17:26:05 -0700] PID 6474 (/usr/lib/cups/filter/pstopdf) exited with no errors.',
'D [25/May/2012:17:26:05 -0700] [Job 168] Filetype: PDF',
'D [25/May/2012:17:26:05 -0700] [Job 168] Driver does not understand PDF input, converting to PostScript',
'D [25/May/2012:17:26:05 -0700] [Job 168] Storing temporary files in /var/spool/cups/tmp',
'D [25/May/2012:17:26:05 -0700] PID 6475 (/usr/lib/cups/filter/pdftopdf) exited with no errors.',
'D [25/May/2012:17:26:05 -0700] [Job 168] Starting process "pdf-to-ps" (generation 1)',
'D [25/May/2012:17:26:06 -0700] [Job 168] Filetype: PostScript',
'D [25/May/2012:17:26:06 -0700] [Job 168] Reading PostScript input ...',
'D [25/May/2012:17:26:06 -0700] [Job 168] --> This document is DSC-conforming!',
'D [25/May/2012:17:26:06 -0700] [Job 168] Job claims to be DSC-conforming, but "%%BeginProlog" was missing before first line with another"%%BeginProlog" comment (is this a TeX/LaTeX/dvips-generated PostScript file?). Assuming start of "Prolog" here.',
'D [25/May/2012:17:26:06 -0700] [Job 168] Inserting option code into "Prolog" section.',
'D [25/May/2012:17:26:06 -0700] [Job 168]',
'D [25/May/2012:17:26:06 -0700] [Job 168] -----------',
'D [25/May/2012:17:26:06 -0700] [Job 168] Found: %%BeginProlog',
'D [25/May/2012:17:26:06 -0700] [Job 168] Found: %%EndProlog',
'D [25/May/2012:17:26:06 -0700] [Job 168]',
'D [25/May/2012:17:26:06 -0700] [Job 168] -----------',
'D [25/May/2012:17:26:06 -0700] [Job 168] Found: %%BeginSetup',
'D [25/May/2012:17:26:06 -0700] [Job 168] Found: %%EndSetup',
"D [25/May/2012:17:26:06 -0700] [Job 168] Inserting PostScript code for CUPS' page accounting",
'D [25/May/2012:17:26:06 -0700] [Job 168] Inserting option code into "Setup" section.',
'D [25/May/2012:17:26:06 -0700] [Job 168]',
'D [25/May/2012:17:26:06 -0700] [Job 168] -----------',
'D [25/May/2012:17:26:06 -0700] [Job 168] New page: %%Page: 1 1',
'D [25/May/2012:17:26:06 -0700] [Job 168]',
'D [25/May/2012:17:26:06 -0700] [Job 168] Found: %%BeginPageSetup',
'D [25/May/2012:17:26:06 -0700] [Job 168] Inserting option code into "PageSetup" section.',
'D [25/May/2012:17:26:06 -0700] [Job 168] Flushing FIFO.',
'D [25/May/2012:17:26:06 -0700] [Job 168]',
'D [25/May/2012:17:26:06 -0700] [Job 168] Starting renderer with command: "foo2zjs-wrapper -z2 -P -L0 -r1200x600 -p1 -T3 -m1 -s7 -n1 "',
'D [25/May/2012:17:26:06 -0700] [Job 168] Starting process "kid3" (generation 1)',
'D [25/May/2012:17:26:06 -0700] [Job 168]',
'D [25/May/2012:17:26:06 -0700] [Job 168] Closing renderer',
'D [25/May/2012:17:26:06 -0700] [Job 168] Starting process "kid4" (generation 2)',
'D [25/May/2012:17:26:06 -0700] [Job 168] Starting process "renderer" (generation 2)',
'D [25/May/2012:17:26:06 -0700] [Job 168] JCL: \x1b%-12345X at PJL',
'D [25/May/2012:17:26:06 -0700] [Job 168] <job data>',
'D [25/May/2012:17:26:06 -0700] [Job 168]',
'D [25/May/2012:17:26:06 -0700] [Job 168] PAGE: 1 1',
'D [25/May/2012:17:26:06 -0700] cupsdMarkDirty(-----S)',
'D [25/May/2012:17:26:06 -0700] [Job 168] STATE: +connecting-to-device',
'D [25/May/2012:17:26:06 -0700] cupsdMarkDirty(-----S)',
'D [25/May/2012:17:26:06 -0700] [Job 168] renderer exited with status 0',
'D [25/May/2012:17:26:06 -0700] [Job 168] kid4 exited with status 0',
'D [25/May/2012:17:26:06 -0700] [Job 168] kid3 finished',
'D [25/May/2012:17:26:06 -0700] [Job 168] kid3 exited with status 0',
'D [25/May/2012:17:26:06 -0700] [Job 168] pdf-to-ps exited with status 0',
'D [25/May/2012:17:26:06 -0700] [Job 168]',
'D [25/May/2012:17:26:06 -0700] [Job 168] Closing foomatic-rip.',
'D [25/May/2012:17:26:06 -0700] PID 6476 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.',
'D [25/May/2012:17:26:06 -0700] cupsdAcceptClient: 36 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 36 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Active clients, printing jobs, and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdAcceptClient: 37 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 37 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 36 1.1 Get-Notifications 1',
'D [25/May/2012:17:26:06 -0700] Get-Notifications /',
'D [25/May/2012:17:26:06 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 37 1.1 Get-Notifications 1',
'D [25/May/2012:17:26:06 -0700] Get-Notifications /',
'D [25/May/2012:17:26:06 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Printing jobs and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAcceptClient: 38 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 38 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Active clients, printing jobs, and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 38 1.1 Get-Job-Attributes 1',
'D [25/May/2012:17:26:06 -0700] Get-Job-Attributes ipp://localhost/jobs/168',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/168) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Printing jobs and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 38 WAITING Closing on EOF',
'D [25/May/2012:17:26:06 -0700] cupsdCloseClient: 38',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 37 WAITING Closing on EOF',
'D [25/May/2012:17:26:06 -0700] cupsdCloseClient: 37',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 34 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Active clients, printing jobs, and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 34 1.1 Get-Notifications 1',
'D [25/May/2012:17:26:06 -0700] Get-Notifications /',
'D [25/May/2012:17:26:06 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Printing jobs and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 36 WAITING Closing on EOF',
'D [25/May/2012:17:26:06 -0700] cupsdCloseClient: 36',
'D [25/May/2012:17:26:06 -0700] [Job 168] prnt/backend/hp.c 745: ERROR: open device failed stat=12: hp:/usb/HP_LaserJet_Professional_P1102wserial000000000Q93422TSI1c',
'D [25/May/2012:17:26:06 -0700] PID 6478 (/usr/lib/cups/backend/hp) stopped with status 1!',
'I [25/May/2012:17:26:06 -0700] [Job 168] Backend returned status 1 (failed)',
'D [25/May/2012:17:26:06 -0700] set_hold_until: hold_until = 1337992266',
'D [25/May/2012:17:26:06 -0700] cupsdMarkDirty(----J-)',
'D [25/May/2012:17:26:06 -0700] cupsdMarkDirty(-----S)',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Printers 1',
'D [25/May/2012:17:26:06 -0700] CUPS-Get-Printers',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Classes 1',
'D [25/May/2012:17:26:06 -0700] CUPS-Get-Classes',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Default 1',
'D [25/May/2012:17:26:06 -0700] CUPS-Get-Default',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAcceptClient: 35 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 35 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 35 1.1 Get-Notifications 1',
'D [25/May/2012:17:26:06 -0700] Get-Notifications /',
'D [25/May/2012:17:26:06 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAcceptClient: 36 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 36 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 36 1.1 Get-Notifications 1',
'D [25/May/2012:17:26:06 -0700] Get-Notifications /',
'D [25/May/2012:17:26:06 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 35 WAITING Closing on EOF',
'D [25/May/2012:17:26:06 -0700] cupsdCloseClient: 35',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 36 WAITING Closing on EOF',
'D [25/May/2012:17:26:06 -0700] cupsdCloseClient: 36',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Printers 1',
'D [25/May/2012:17:26:06 -0700] CUPS-Get-Printers',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Classes 1',
'D [25/May/2012:17:26:06 -0700] CUPS-Get-Classes',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 POST / HTTP/1.1',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:06 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:06 -0700] cupsdReadClient: 20 1.1 CUPS-Get-Default 1',
'D [25/May/2012:17:26:06 -0700] CUPS-Get-Default',
'D [25/May/2012:17:26:06 -0700] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
'D [25/May/2012:17:26:06 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:07 -0700] cupsdReadClient: 34 POST / HTTP/1.1',
'D [25/May/2012:17:26:07 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:07 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:07 -0700] cupsdReadClient: 34 1.1 Get-Job-Attributes 1',
'D [25/May/2012:17:26:07 -0700] Get-Job-Attributes ipp://localhost/jobs/165',
'D [25/May/2012:17:26:07 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/165) from localhost',
'D [25/May/2012:17:26:07 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:07 -0700] cupsdReadClient: 34 POST / HTTP/1.1',
'D [25/May/2012:17:26:07 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:07 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:07 -0700] cupsdReadClient: 34 1.1 Get-Job-Attributes 1',
'D [25/May/2012:17:26:07 -0700] Get-Job-Attributes ipp://localhost/jobs/168',
'D [25/May/2012:17:26:07 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/168) from localhost',
'D [25/May/2012:17:26:07 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:07 -0700] cupsdReadClient: 34 POST / HTTP/1.1',
'D [25/May/2012:17:26:07 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:07 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:07 -0700] cupsdReadClient: 34 1.1 Cancel-Subscription 1',
'D [25/May/2012:17:26:07 -0700] Cancel-Subscription /',
'D [25/May/2012:17:26:07 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:26:07 -0700] cupsdMarkDirty(-----S)',
'D [25/May/2012:17:26:07 -0700] Returning IPP successful-ok for Cancel-Subscription (/) from localhost',
'D [25/May/2012:17:26:07 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:07 -0700] cupsdAcceptClient: 35 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:07 -0700] cupsdReadClient: 35 GET /admin/log/error_log HTTP/1.1',
'D [25/May/2012:17:26:07 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:07 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:07 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:08 -0700] cupsdAcceptClient: 36 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:08 -0700] cupsdReadClient: 36 POST / HTTP/1.1',
'D [25/May/2012:17:26:08 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:08 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:08 -0700] cupsdReadClient: 36 1.1 Get-Printer-Attributes 1',
'D [25/May/2012:17:26:08 -0700] Get-Printer-Attributes ipp://localhost/printers/HP-LaserJet-Pro-P1102w-2',
'D [25/May/2012:17:26:08 -0700] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/HP-LaserJet-Pro-P1102w-2) from localhost',
'D [25/May/2012:17:26:08 -0700] cupsdSetBusyState: Dirty files',
'I [25/May/2012:17:26:12 -0700] Saving job cache file "/var/cache/cups/job.cache"...',
'I [25/May/2012:17:26:12 -0700] Saving subscriptions.conf...',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Not busy',
'D [25/May/2012:17:26:12 -0700] cupsdReadClient: 36 WAITING Closing on EOF',
'D [25/May/2012:17:26:12 -0700] cupsdCloseClient: 36',
'D [25/May/2012:17:26:12 -0700] cupsdAcceptClient: 36 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:12 -0700] cupsdReadClient: 36 POST / HTTP/1.1',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Active clients',
'D [25/May/2012:17:26:12 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:12 -0700] cupsdReadClient: 36 1.1 Get-Printer-Attributes 1',
'D [25/May/2012:17:26:12 -0700] Get-Printer-Attributes ipp://localhost/printers/HP-LaserJet-Pro-P1102w-2',
'D [25/May/2012:17:26:12 -0700] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/HP-LaserJet-Pro-P1102w-2) from localhost',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Not busy',
'D [25/May/2012:17:26:12 -0700] cupsdAcceptClient: 37 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:12 -0700] cupsdReadClient: 35 WAITING Closing on EOF',
'D [25/May/2012:17:26:12 -0700] cupsdCloseClient: 35',
'D [25/May/2012:17:26:12 -0700] cupsdReadClient: 37 GET /admin/log/error_log HTTP/1.1',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Active clients',
'D [25/May/2012:17:26:12 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Not busy',
'D [25/May/2012:17:26:12 -0700] cupsdReadClient: 37 POST / HTTP/1.1',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Active clients',
'D [25/May/2012:17:26:12 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:12 -0700] cupsdReadClient: 37 1.1 Get-Jobs 1',
'D [25/May/2012:17:26:12 -0700] Get-Jobs ipp://localhost/printers/',
'D [25/May/2012:17:26:12 -0700] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Not busy',
'D [25/May/2012:17:26:12 -0700] cupsdReadClient: 37 POST / HTTP/1.1',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Active clients',
'D [25/May/2012:17:26:12 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:12 -0700] cupsdReadClient: 37 1.1 Get-Jobs 1',
'D [25/May/2012:17:26:12 -0700] Get-Jobs ipp://localhost/printers/',
'D [25/May/2012:17:26:12 -0700] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Not busy',
'D [25/May/2012:17:26:12 -0700] cupsdReadClient: 37 POST / HTTP/1.1',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Active clients',
'D [25/May/2012:17:26:12 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:12 -0700] cupsdReadClient: 37 1.1 Create-Printer-Subscription 1',
'D [25/May/2012:17:26:12 -0700] Create-Printer-Subscription /',
'D [25/May/2012:17:26:12 -0700] cupsdCreateSubscription(con=0x7fc891e88260(37), uri="/")',
'D [25/May/2012:17:26:12 -0700] pullmethod="ippget"',
'D [25/May/2012:17:26:12 -0700] notify-lease-duration=86400',
'D [25/May/2012:17:26:12 -0700] notify-time-interval=0',
'D [25/May/2012:17:26:12 -0700] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")',
'D [25/May/2012:17:26:12 -0700] Added subscription 220 for server',
'D [25/May/2012:17:26:12 -0700] cupsdMarkDirty(-----S)',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:12 -0700] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost',
'D [25/May/2012:17:26:12 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:13 -0700] cupsdReadClient: 37 POST / HTTP/1.1',
'D [25/May/2012:17:26:13 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:13 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:13 -0700] cupsdReadClient: 37 1.1 Get-Notifications 1',
'D [25/May/2012:17:26:13 -0700] Get-Notifications /',
'D [25/May/2012:17:26:13 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:26:13 -0700] Returning IPP successful-ok for Get-Notifications (/) from localhost',
'D [25/May/2012:17:26:13 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:18 -0700] cupsdReadClient: 37 POST / HTTP/1.1',
'D [25/May/2012:17:26:18 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:18 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:18 -0700] cupsdReadClient: 37 1.1 Get-Job-Attributes 1',
'D [25/May/2012:17:26:18 -0700] Get-Job-Attributes ipp://localhost/jobs/168',
'D [25/May/2012:17:26:18 -0700] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/168) from localhost',
'D [25/May/2012:17:26:18 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:18 -0700] cupsdReadClient: 37 POST / HTTP/1.1',
'D [25/May/2012:17:26:18 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:18 -0700] cupsdAuthorize: No authentication data provided.',
'D [25/May/2012:17:26:18 -0700] cupsdReadClient: 37 1.1 Cancel-Subscription 1',
'D [25/May/2012:17:26:18 -0700] Cancel-Subscription /',
'D [25/May/2012:17:26:18 -0700] cupsdIsAuthorized: requesting-user-name="david"',
'D [25/May/2012:17:26:18 -0700] cupsdMarkDirty(-----S)',
'D [25/May/2012:17:26:18 -0700] Returning IPP successful-ok for Cancel-Subscription (/) from localhost',
'D [25/May/2012:17:26:18 -0700] cupsdSetBusyState: Dirty files',
'D [25/May/2012:17:26:18 -0700] cupsdAcceptClient: 35 from localhost:631 (IPv6)',
'D [25/May/2012:17:26:18 -0700] cupsdReadClient: 37 WAITING Closing on EOF',
'D [25/May/2012:17:26:18 -0700] cupsdCloseClient: 37',
'D [25/May/2012:17:26:18 -0700] cupsdReadClient: 35 GET /admin/log/error_log HTTP/1.1',
'D [25/May/2012:17:26:18 -0700] cupsdSetBusyState: Active clients and dirty files',
'D [25/May/2012:17:26:18 -0700] cupsdAuthorize: No authentication data provided.']}
Page 9 (Locale issues):
{'printer_page_size': u'Letter',
'system_locale_lang': None,
'user_locale_ctype': 'en_CA',
'user_locale_messages': 'en_CA'}
More information about the cups-devel
mailing list