Login
[x]
Log in using an account from:
Fedora Account System
Red Hat Associate
Red Hat Customer
Or login using a Red Hat Bugzilla account
Forgot Password
Login:
Hide Forgot
Create an Account
Red Hat Bugzilla – Attachment 589139 Details for
Bug 827632
Printing PDF fails (although log says it's been ok), but postscript is ok
[?]
New
Simple Search
Advanced Search
My Links
Browse
Requests
Reports
Current State
Search
Tabular reports
Graphical reports
Duplicates
Other Reports
User Changes
Plotly Reports
Bug Status
Bug Severity
Non-Defaults
|
Product Dashboard
Help
Page Help!
Bug Writing Guidelines
What's new
Browser Support Policy
5.0.4.rh83 Release notes
FAQ
Guides index
User guide
Web Services
Contact
Legal
This site requires JavaScript to be enabled to function correctly, please enable it.
Output from S-C-P.
troubleshoot.txt (text/plain), 115.62 KB, created by
Dan Naughton
on 2012-06-04 12:51:36 UTC
(
hide
)
Description:
Output from S-C-P.
Filename:
MIME Type:
Creator:
Dan Naughton
Created:
2012-06-04 12:51:36 UTC
Size:
115.62 KB
patch
obsolete
>Page 1 (Scheduler not running?): >{'cups_connection_failure': False} >Page 2 (Is local server publishing?): >{'local_server_exporting_printers': False} >Page 3 (Choose printer): >{'cups_dest': <cups.Dest RICOH-Aficio-CL1000N (default)>, > 'cups_instance': None, > 'cups_queue': 'RICOH-Aficio-CL1000N', > 'cups_queue_listed': True} >Page 4 (Check printer sanity): >{'cups_device_uri_scheme': u'dnssd', > 'cups_printer_dict': {'device-uri': u'dnssd://RICOH%20Aficio%20CL1000N._pdl-datastream._tcp.local/', > 'printer-info': u'RICOH Aficio CL1000N', > 'printer-is-shared': True, > 'printer-location': u'', > 'printer-make-and-model': u'Ricoh Aficio CL1000N PS', > 'printer-state': 3, > 'printer-state-message': u'Ready to print.', > 'printer-state-reasons': [u'none'], > 'printer-type': 8556748, > 'printer-uri-supported': u'ipp://localhost:631/printers/RICOH-Aficio-CL1000N'}, > 'cups_printer_remote': False, > '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': True, > 'compression-supported': [u'none', u'gzip'], > 'copies-default': 1, > 'copies-supported': (1, 9999), > 'cups-version': u'1.5.2', > 'device-uri': u'dnssd://RICOH%20Aficio%20CL1000N._pdl-datastream._tcp.local/', > 'document-format-default': u'application/octet-stream', > 'document-format-supported': [u'application/octet-stream', > u'application/pdf', > u'application/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/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'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-ids-supported': True, > 'job-k-limit': 0, > 'job-k-octets-supported': (0, 22674648), > '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'], > 'jpeg-k-octets-supported': (0, 22674648), > 'jpeg-x-dimension-supported': (0, 65535), > 'jpeg-y-dimension-supported': (1, 65535), > 'marker-change-time': 1338758230, > 'marker-colors': [u'#000000', > u'none', > u'#00FFFF', > u'#FF00FF', > u'#FFFF00'], > 'marker-levels': [-1, -1, -1, -1, -1], > 'marker-names': [u'Black Toner', > u'Waste Toner', > u'Cyan Toner', > u'Magenta Toner', > u'Yellow Toner'], > 'marker-types': [u'toner', > u'wasteToner', > u'toner', > u'toner', > u'toner'], > 'media-bottom-margin-supported': [423], > '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': [423], > 'media-right-margin-supported': [423], > 'media-source-supported': [u'1-tray', > u'2-tray', > u'auto'], > 'media-supported': [u'iso_a4_210x297mm', > u'iso_a5_148x210mm', > u'na_legal_8.5x14in', > u'na_letter_8.5x11in', > u'na_invoice_5.5x8.5in', > u'na_executive_7.25x10.5in', > u'custom_min_104.77x209.9mm', > u'custom_max_8.5x14in'], > 'media-top-margin-supported': [423], > 'media-type-supported': [u'stationery', > u'stationery-recycled', > u'special', > u'colored', > u'stationery-letterhead', > u'stationery-preprinted', > u'labels', > u'photographic-glossy', > u'cardstock', > u'ohp', > u'thick', > u'none'], > '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, > 14, > 16, > 17, > 18, > 19, > 20, > 21, > 22, > 23, > 24, > 25, > 26, > 27, > 28, > 34, > 35, > 37, > 38, > 56, > 57, > 59, > 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'color', > 'output-mode-supported': [u'monochrome', > u'color'], > 'page-ranges-supported': True, > 'pages-per-minute': 31, > 'pages-per-minute-color': 31, > 'pdf-k-octets-supported': (0, 22674648), > 'pdf-versions-supported': [u'adobe-1.2', > u'adobe-1.3', > u'adobe-1.4', > u'adobe-1.5', > u'adobe-1.6', > u'adobe-1.7', > u'iso-19005-1_2005', > u'iso-32000-1_2008', > u'pwg-5102.3'], > 'pdl-override-supported': [u'attempted'], > 'port-monitor': u'none', > 'port-monitor-supported': [u'none'], > 'print-color-mode-default': u'color', > 'print-color-mode-supported': [u'monochrome', > u'color'], > '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': None, > 'printer-error-policy': u'stop-printer', > 'printer-error-policy-supported': [u'abort-job', > u'retry-current-job', > u'retry-job', > u'stop-printer'], > 'printer-icons': u'http://localhost:631/icons/RICOH-Aficio-CL1000N.png', > 'printer-info': u'RICOH Aficio CL1000N', > 'printer-is-accepting-jobs': True, > 'printer-is-shared': True, > 'printer-location': u'', > 'printer-make-and-model': u'Ricoh Aficio CL1000N PS', > 'printer-more-info': u'http://localhost:631/printers/RICOH-Aficio-CL1000N', > 'printer-name': u'RICOH-Aficio-CL1000N', > 'printer-op-policy': u'default', > 'printer-op-policy-supported': [u'authenticated', > u'default'], > 'printer-resolution-default': (600, 600, 3), > 'printer-resolution-supported': [(600, > 600, > 3)], > 'printer-settable-attributes-supported': [u'printer-info', > u'printer-location'], > 'printer-state': 3, > 'printer-state-change-time': 1338758230, > 'printer-state-message': u'Ready to print.', > 'printer-state-reasons': [u'none'], > 'printer-type': 8556748, > 'printer-up-time': 1338813205, > 'printer-uri-supported': [u'ipp://localhost:631/printers/RICOH-Aficio-CL1000N'], > 'printer-uuid': u'urn:uuid:fb7b9a42-19fa-3f54-62c2-ca66625d67a1', > 'queued-job-count': 0, > 'server-is-sharing-printers': False, > 'sides-default': u'one-sided', > 'sides-supported': [u'one-sided'], > 'uri-authentication-supported': [u'requesting-user-name'], > 'uri-security-supported': [u'none'], > 'which-jobs-supported': [u'completed', > u'not-completed', > u'aborted', > u'all', > u'canceled', > u'pending', > u'pending-held', > u'processing', > u'processing-stopped']}} >Page 5 (Check PPD sanity): >{'cups_printer_ppd_defaults': {u'General': {u'Collate': u'False', > u'ColorModel': u'CMYK', > u'Duplex': u'None', > u'InputSlot': u'Auto', > u'MediaType': u'Plain', > u'PageRegion': u'Letter', > u'PageSize': u'Letter', > u'RIPaperPolicy': u'PromptUser', > u'RIPrintMode': u'0rhit', > u'RIWMText': u'Confidential', > u'RIWatermark': u'Off', > u'RIwmAngle': u'45Deg', > u'RIwmFont': u'HelveticaB', > u'RIwmSize': u'36', > u'RIwmTextStyle': u'Gray', > u'RPSBitsPerPixel': u'1BitsPerPixel', > u'RPSBlackMode': u'GRAY', > u'RPSBlackOverPrint': u'False', > u'RPSColorRendDict': u'Auto', > u'RPSDitherType': u'Auto', > u'RPSRGBcorrect': u'DetailBright', > u'Rcmyksimulation': u'Off'}, > u'InstallableOptions': {u'Option1': u'None', > u'Option5': u'False'}, > u'JobLog': {u'JobType': u'Normal', > u'LockedPrintPassword': u'None', > u'UserCode': u'None'}}, > 'cups_printer_ppd_valid': True, > 'missing_pkgs_and_exes': ([], [])} >Page 6 (Local or remote?): >{'printer_is_remote': False} >Page 7 (Choose device): >{'cups_device_dict': {'device-class': u'network', > 'device-id': u'MFG:RICOH;MDL:Aficio CL1000N;FZY:1;', > 'device-info': u'RICOH Aficio CL1000N', > 'device-location': u'', > 'device-make-and-model': u'RICOH RICOH Aficio CL1000N'}} >Page 8 (Printer state reasons): >{'printer-state-message': u'Ready to print.', > 'printer-state-reasons': [u'none']} >Page 9 (Verify packages): >{'packages_verification': {'cups': ['.M....... c /etc/cups/classes.conf', > '.M....... c /etc/cups/subscriptions.conf', > '.......T. c /etc/pam.d/cups'], > 'foomatic': ['S.?...... /usr/bin/foomatic-perl-data'], > 'gutenprint': [], > 'hpijs': ['S.?...... /usr/bin/hpijs', > 'S.?...... /usr/lib/cups/filter/hpcups', > 'S.?...... /usr/lib/cups/filter/hpcupsfax'], > 'hplip': ['S.?...... /usr/lib/cups/backend/hp', > 'S.?...... /usr/lib/cups/filter/hpps'], > 'system-config-printer': []}} >Page 10 (Error log checkpoint): >{'cups_server_settings': {'BrowseLocalProtocols': 'CUPS dnssd', > 'DefaultAuthType': 'Basic', > 'JobPrivateAccess': 'default', > 'JobPrivateValues': 'default', > 'MaxLogSize': '0', > 'SubscriptionPrivateAccess': 'default', > 'SubscriptionPrivateValues': 'default', > 'SystemGroup': 'sys root', > 'WebInterface': 'Yes', > '_debug_logging': '0', > '_remote_admin': '0', > '_remote_any': '0', > '_remote_printers': '1', > '_share_printers': '0', > '_user_cancel_any': '0'}, > 'error_log_checkpoint': 12708, > 'error_log_debug_logging_set': True} >Page 11 (Print test page): >{'test_page_attempted': '04/Jun/2012:07:33:53 +0000', > 'test_page_completions': [(12, u'Job completed.')], > 'test_page_job_id': [12], > 'test_page_job_status': [(True, > 12, > 'RICOH-Aficio-CL1000N', > 'Test Page', > 'Completed', > {'attributes-charset': u'utf-8', > 'attributes-natural-language': u'en-us', > 'document-count': 0, > 'document-format': u'application/vnd.cups-banner', > 'job-hold-until': u'no-hold', > 'job-id': 12, > 'job-k-octets': 1, > 'job-media-progress': 0, > 'job-media-sheets-completed': 0, > 'job-more-info': u'http://localhost:631/jobs/12', > 'job-preserved': False, > 'job-printer-state-message': u'', > 'job-printer-state-reasons': [u'none'], > 'job-printer-up-time': 1338813244, > 'job-printer-uri': u'ipp://localhost:631/printers/RICOH-Aficio-CL1000N', > 'job-priority': 50, > 'job-sheets': [u'none', u'none'], > 'job-state': 9, > 'job-state-reasons': u'job-completed-successfully', > 'job-uri': u'ipp://localhost:631/jobs/12', > 'job-uuid': u'urn:uuid:3f309fad-fe40-320c-613d-a3e987536257', > 'printer-uri': u'ipp://localhost/printers/RICOH-Aficio-CL1000N', > 'time-at-completed': 1338813243, > 'time-at-creation': 1338813233, > 'time-at-processing': 1338813233})], > 'test_page_successful': True} >Page 12 (Error log fetch): >{'error_log': ['D [04/Jun/2012:07:33:46 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:46 -0500] cupsdReadClient: 15 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:46 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:46 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:46 -0500] cupsdReadClient: 15 1.1 Get-Jobs 1', > 'D [04/Jun/2012:07:33:46 -0500] Get-Jobs ipp://localhost/printers/', > 'D [04/Jun/2012:07:33:46 -0500] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost', > 'D [04/Jun/2012:07:33:46 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:46 -0500] cupsdReadClient: 15 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:46 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:46 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:46 -0500] cupsdReadClient: 15 1.1 Get-Jobs 1', > 'D [04/Jun/2012:07:33:46 -0500] Get-Jobs ipp://localhost/printers/', > 'D [04/Jun/2012:07:33:46 -0500] [Job 6] Loading attributes...', > 'D [04/Jun/2012:07:33:46 -0500] [Job 7] Loading attributes...', > 'D [04/Jun/2012:07:33:46 -0500] [Job 8] Loading attributes...', > 'D [04/Jun/2012:07:33:46 -0500] [Job 9] Loading attributes...', > 'D [04/Jun/2012:07:33:46 -0500] [Job 10] Loading attributes...', > 'D [04/Jun/2012:07:33:46 -0500] [Job 11] Loading attributes...', > 'D [04/Jun/2012:07:33:46 -0500] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost', > 'D [04/Jun/2012:07:33:46 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:46 -0500] cupsdReadClient: 15 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:46 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:46 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:46 -0500] cupsdReadClient: 15 1.1 Create-Printer-Subscription 1', > 'D [04/Jun/2012:07:33:46 -0500] Create-Printer-Subscription /', > 'D [04/Jun/2012:07:33:46 -0500] cupsdCreateSubscription(con=0x7f6ba0cb6ec0(15), uri="/")', > 'D [04/Jun/2012:07:33:46 -0500] pullmethod="ippget"', > 'D [04/Jun/2012:07:33:46 -0500] notify-lease-duration=86400', > 'D [04/Jun/2012:07:33:46 -0500] notify-time-interval=0', > 'D [04/Jun/2012:07:33:46 -0500] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")', > 'D [04/Jun/2012:07:33:46 -0500] Added subscription #32 for server.', > 'D [04/Jun/2012:07:33:46 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:46 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:46 -0500] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost', > 'D [04/Jun/2012:07:33:46 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:47 -0500] cupsdReadClient: 15 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:47 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:47 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:47 -0500] cupsdReadClient: 15 1.1 Get-Notifications 1', > 'D [04/Jun/2012:07:33:47 -0500] Get-Notifications /', > 'D [04/Jun/2012:07:33:47 -0500] cupsdIsAuthorized: requesting-user-name="root"', > 'D [04/Jun/2012:07:33:47 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [04/Jun/2012:07:33:47 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAcceptClient: skipping getpeercon()', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAcceptClient: 19 from localhost (Domain)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 19 POST /printers/RICOH-Aficio-CL1000N HTTP/1.1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 19 1.1 Print-Job 1', > 'D [04/Jun/2012:07:33:53 -0500] Print-Job ipp://localhost/printers/RICOH-Aficio-CL1000N', > 'D [04/Jun/2012:07:33:53 -0500] [Job ???] Auto-typing file...', > 'I [04/Jun/2012:07:33:53 -0500] [Job ???] Request file type is application/vnd.cups-banner.', > 'D [04/Jun/2012:07:33:53 -0500] add_job: setting context of job to UNKNOWN SL', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(----J-)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] add_job: requesting-user-name="root"', > 'D [04/Jun/2012:07:33:53 -0500] Adding default job-sheets values "none,none"...', > 'I [04/Jun/2012:07:33:53 -0500] [Job 12] Adding start banner page "none".', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(----J-)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'I [04/Jun/2012:07:33:53 -0500] [Job 12] Adding end banner page "none".', > 'I [04/Jun/2012:07:33:53 -0500] [Job 12] File of type application/vnd.cups-banner queued by "root".', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] hold_until=0', > 'I [04/Jun/2012:07:33:53 -0500] [Job 12] Queued on "RICOH-Aficio-CL1000N" by "root".', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(----J-)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] job-sheets=none,none', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] argv[0]="RICOH-Aficio-CL1000N"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] argv[1]="12"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] argv[2]="root"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] argv[3]="Test Page"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] argv[4]="1"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] argv[5]="job-uuid=urn:uuid:3f309fad-fe40-320c-613d-a3e987536257 job-originating-host-name=localhost time-at-creation=1338813233 time-at-processing=1338813233 AP_D_InputSlot="', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] argv[6]="/var/spool/cups/d00012-001"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[0]="CUPS_CACHEDIR=/var/cache/cups"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[1]="CUPS_DATADIR=/usr/share/cups"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[6]="CUPS_SERVERROOT=/etc/cups"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[7]="CUPS_STATEDIR=/var/run/cups"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[8]="HOME=/var/spool/cups/tmp"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[10]="SERVER_ADMIN=root@mcase820"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[11]="SOFTWARE=CUPS/1.5.2"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[12]="TMPDIR=/var/spool/cups/tmp"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[13]="USER=root"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[15]="CUPS_ENCRYPTION=IfRequested"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[16]="IPP_PORT=631"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[17]="CHARSET=utf-8"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[18]="LANG=en_US.UTF-8"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[19]="PPD=/etc/cups/ppd/RICOH-Aficio-CL1000N.ppd"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[20]="RIP_MAX_CACHE=128m"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[21]="CONTENT_TYPE=application/vnd.cups-banner"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[22]="DEVICE_URI=dnssd://RICOH%20Aficio%20CL1000N._pdl-datastream._tcp.local/"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[23]="PRINTER_INFO=RICOH Aficio CL1000N"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[24]="PRINTER_LOCATION="', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[25]="PRINTER=RICOH-Aficio-CL1000N"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[26]="PRINTER_STATE_REASONS=none"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[27]="CUPS_FILETYPE=document"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[28]="FINAL_CONTENT_TYPE=printer/RICOH-Aficio-CL1000N"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] envp[29]="AUTH_I****"', > 'I [04/Jun/2012:07:33:53 -0500] [Job 12] Started filter /usr/lib/cups/filter/bannertops (PID 21882)', > 'I [04/Jun/2012:07:33:53 -0500] [Job 12] Started filter /usr/lib/cups/filter/pstops (PID 21883)', > 'I [04/Jun/2012:07:33:53 -0500] [Job 12] Started filter /usr/lib/cups/filter/foomatic-rip (PID 21884)', > 'I [04/Jun/2012:07:33:53 -0500] [Job 12] Started backend /usr/lib/cups/backend/dnssd (PID 21885)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] Returning IPP successful-ok for Print-Job (ipp://localhost/printers/RICOH-Aficio-CL1000N) from localhost', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] load_banner(filename="/var/spool/cups/d00012-001")', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] 1 #CUPS-BANNER', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] 2 Show printer-name printer-info printer-location printer-make-and-model printer-driver-name printer-driver-version paper-size imageable-area', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] 3 Header Printer Test Page', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] 4 Footer Printer Test Page', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] 5 Notice CUPS 1.5.2.', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] 6 Image images/cups.png', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] 7 Image images/color-wheel.png', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Resolving "RICOH Aficio CL1000N._pdl-datastream._tcp.local"...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: +connecting-to-device', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Resolving "RICOH Aficio CL1000N", regtype="_pdl-datastream._tcp", domain="local."...', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Page = 612x792; 12,12 to 600,780', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Resolved as "socket://192.168.1.9:9100"...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -connecting-to-device,offline-report', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Executing backend "/usr/lib/cups/backend/socket"...', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Getting input from file', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] foomatic-rip version 4.0.13.247 running...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Parsing PPD file ...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option ColorSpace', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option Option1', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option Option5', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option Resolution', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RIPaperPolicy', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option PageSize', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option ImageableArea', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option PaperDimension', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option InputSlot', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option LeadingEdge', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option Duplex', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option Collate', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RIPrintMode', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option ColorModel', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RPSBitsPerPixel', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RPSRGBcorrect', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RPSColorRendDict', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RPSDitherType', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RPSBlackMode', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RPSBlackOverPrint', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option Rcmyksimulation', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: +connecting-to-device', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option MediaType', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Looking up "192.168.1.9"...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RIWatermark', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RIWMText', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RIwmFont', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RIwmSize', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RIwmAngle', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option RIwmTextStyle', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option ScreenProc', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option Font', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Page = 612x792; 12,12 to 600,780', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] slow_collate=0, slow_duplex=0, slow_order=0', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Before copy_comments - %!PS-Adobe-3.0', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option ColorSep', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %!PS-Adobe-3.0', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%BoundingBox: 12 12 600 780', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %cupsRotation: 0', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%Creator: bannertops/CUPS v1.5.2', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%CreationDate: Mon 04 Jun 2012 07:33:53 AM CDT', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%LanguageLevel: 2', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%DocumentData: Clean7Bit', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%Title: (Test Page)', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%For: (root)', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%Pages: 1', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%DocumentSuppliedResources: font Monospace', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%+ font Monospace-Bold', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%+ font Monospace-BoldOblique', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%+ font Monospace-Oblique', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] %%EndComments', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Before copy_prolog - %%BeginProlog', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option JobType', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option LockedPrintPassword', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Added option UserCode', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Parameter Summary', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] -----------------', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Spooler: cups', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Printer: RICOH-Aficio-CL1000N', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Shell: /bin/bash', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] PPD file: /etc/cups/ppd/RICOH-Aficio-CL1000N.ppd', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] ATTR file:', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Printer model: Ricoh Aficio CL1000N PS', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Job title: Test Page', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] File(s) to be printed:', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] <STDIN>', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > "D [04/Jun/2012:07:33:53 -0500] [Job 12] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts", > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Printing system options:', > "D [04/Jun/2012:07:33:53 -0500] [Job 12] Pondering option 'job-uuid=urn:uuid:3f309fad-fe40-320c-613d-a3e987536257'", > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Unknown option job-uuid=urn:uuid:3f309fad-fe40-320c-613d-a3e987536257.', > "D [04/Jun/2012:07:33:53 -0500] [Job 12] Pondering option 'job-originating-host-name=localhost'", > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Unknown option job-originating-host-name=localhost.', > "D [04/Jun/2012:07:33:53 -0500] [Job 12] Pondering option 'time-at-creation=1338813233'", > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Unknown option time-at-creation=1338813233.', > "D [04/Jun/2012:07:33:53 -0500] [Job 12] Pondering option 'time-at-processing=1338813233'", > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Unknown option time-at-processing=1338813233.', > "D [04/Jun/2012:07:33:53 -0500] [Job 12] Pondering option 'AP_D_InputSlot'", > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Unknown boolean option "AP_D_InputSlot".', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Options from the PPD file:', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] ================================================', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] File: <STDIN>', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] ================================================', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Filetype: PostScript', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Reading PostScript input ...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> This document is DSC-conforming!', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found %RBINumCopies: 1', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] -----------', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginProlog', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] PNG image: 128x128x8, color_type=6 (RGB+ALPHA)', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] PNG image: 192x128x8, color_type=2 (RGB)', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Before copy_setup - %%Page: coverpage 1', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Before page loop - %%Page: coverpage 1', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Copying page 1...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%EndProlog', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] -----------', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginSetup', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *Option1 None', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: Option1=None', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *Option5 False', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: Option5=False', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] pagew = 588.0, pagel = 768.0', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RIPaperPolicy PromptUser', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RIPaperPolicy=PromptUser', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] PageLeft = 12.0, PageRight = 600.0', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] PageTop = 780.0, PageBottom = 12.0', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] PageWidth = 612.0, PageLength = 792.0', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *PageSize Letter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: PageSize=Letter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RPSBitsPerPixel 1BitsPerPixel', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RPSBitsPerPixel=1BitsPerPixel', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RIPrintMode 0rhit', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RIPrintMode=0rhit', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *Duplex None', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: Duplex=None', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *ColorModel CMYK', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: ColorModel=CMYK', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RPSRGBcorrect DetailBright', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RPSRGBcorrect=DetailBright', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RPSColorRendDict Auto', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RPSColorRendDict=Auto', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RPSDitherType Auto', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RPSDitherType=Auto', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RPSBlackMode GRAY', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RPSBlackMode=GRAY', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RPSBlackOverPrint False', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RPSBlackOverPrint=False', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *Rcmyksimulation Off', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: Rcmyksimulation=Off', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *Collate False', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: Collate=False', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *MediaType Plain', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: MediaType=Plain', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *LockedPrintPassword None', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: LockedPrintPassword=None', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Setting option', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *JobType Normal', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: JobType=Normal', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Setting option', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %% FoomaticRIPOptionSetting: JobType=Normal', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: JobType=Normal', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Setting option', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *UserCode None', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: UserCode=None', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Setting option', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RIWatermark Off', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RIWatermark=Off', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RIWMText Confidential', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RIWMText=Confidential', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RIwmFont HelveticaB', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RIwmFont=HelveticaB', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RIwmSize 36', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RIwmSize=36', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RIwmAngle 45Deg', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RIwmAngle=45Deg', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginFeature: *RIwmTextStyle Gray', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Option: RIwmTextStyle=Gray', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] --> Option will be set by PostScript interpreter', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%EndSetup', > "D [04/Jun/2012:07:33:53 -0500] [Job 12] Inserting PostScript code for CUPS' page accounting", > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] -----------', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] New page: %%Page: coverpage 1', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Found: %%BeginPageSetup', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Inserting option code into "PageSetup" section.', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 1 pages...', > 'D [04/Jun/2012:07:33:53 -0500] PID 21882 (/usr/lib/cups/filter/bannertops) exited with no errors.', > 'D [04/Jun/2012:07:33:53 -0500] PID 21883 (/usr/lib/cups/filter/pstops) exited with no errors.', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Flushing FIFO.', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] ATTR: marker-colors=#000000,none,#00FFFF,#FF00FF,#FFFF00', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(P-----)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] ATTR: marker-names="Black Toner","Waste Toner","Cyan Toner","Magenta Toner","Yellow Toner"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(P-----)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] ATTR: marker-types=toner,wasteToner,toner,toner,toner', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(P-----)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] ATTR: marker-levels=-1,-1,-1,-1,-1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(P-----)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] new_supply_state=0, change_state=ffff', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -developer-low-report', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -developer-empty-warning', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -marker-supply-low-report', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -marker-supply-empty-warning', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -opc-near-eol-report', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -opc-life-over-warning', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -toner-low-report', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -toner-empty-warning', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] new_state=0, change_state=ffff', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -media-low-report', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -media-empty-warning', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -door-open-report', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -media-jam-warning', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -input-tray-missing-warning', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -output-tray-missing-warning', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -marker-supply-missing-warning', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -output-area-almost-full-report', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -output-area-full-warning', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] backendWaitLoop(snmp_fd=5, addr=0x7fece48d29d8, side_cb=0x7fece2eecef0)', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Starting renderer with command: "printf "%%!PS-Adobe-3.0\\n%%%% %%%%\\nmark\\n() () (20`date +%y%m%d%R | sed \'s/://\'`) {setuserinfo} stopped\\ncleartomark\\n"%%%%; cat;"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Starting process "kid3" (generation 1)', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Starting process "kid4" (generation 2)', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Starting process "renderer" (generation 2)', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] JCL: \x1b%-12345X@PJL', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] <job data>', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Connecting to 192.168.1.9:9100', > 'I [04/Jun/2012:07:33:53 -0500] [Job 12] Connecting to printer.', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Set job-printer-state-message to "Connecting to printer.", current level=INFO', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] STATE: -connecting-to-device', > 'I [04/Jun/2012:07:33:53 -0500] [Job 12] Connected to printer.', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Set job-printer-state-message to "Connected to printer.", current level=INFO', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Connected to 192.168.1.9:9100...', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAcceptClient: skipping getpeercon()', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAcceptClient: 22 from localhost (Domain)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 1.1 Get-Notifications 1', > 'D [04/Jun/2012:07:33:53 -0500] Get-Notifications /', > 'D [04/Jun/2012:07:33:53 -0500] cupsdIsAuthorized: requesting-user-name="root"', > 'D [04/Jun/2012:07:33:53 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAcceptClient: skipping getpeercon()', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAcceptClient: 23 from localhost (Domain)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 WAITING Closing on EOF', > 'D [04/Jun/2012:07:33:53 -0500] cupsdCloseClient: 22', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 15 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 15 1.1 Get-Notifications 1', > 'D [04/Jun/2012:07:33:53 -0500] Get-Notifications /', > 'D [04/Jun/2012:07:33:53 -0500] cupsdIsAuthorized: requesting-user-name="root"', > 'D [04/Jun/2012:07:33:53 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] backendRunLoop(print_fd=0, device_fd=6, snmp_fd=5, addr=0x7fece48d29d8, use_bc=1, side_cb=0x7fece2eecef0)', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] ATTR: marker-levels=-1,-1,-1,-1,-1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(P-----)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] new_supply_state=0, change_state=0', > 'D [04/Jun/2012:07:33:53 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] new_state=0, change_state=0', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAcceptClient: skipping getpeercon()', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAcceptClient: 22 from localhost (Domain)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Printers 1', > 'D [04/Jun/2012:07:33:53 -0500] CUPS-Get-Printers', > 'D [04/Jun/2012:07:33:53 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Classes 1', > 'D [04/Jun/2012:07:33:53 -0500] CUPS-Get-Classes', > 'D [04/Jun/2012:07:33:53 -0500] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Default 1', > 'D [04/Jun/2012:07:33:53 -0500] CUPS-Get-Default', > 'D [04/Jun/2012:07:33:53 -0500] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAcceptClient: skipping getpeercon()', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAcceptClient: 24 from localhost (Domain)', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 24 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 24 1.1 Get-Notifications 1', > 'D [04/Jun/2012:07:33:53 -0500] Get-Notifications /', > 'D [04/Jun/2012:07:33:53 -0500] cupsdIsAuthorized: requesting-user-name="root"', > 'D [04/Jun/2012:07:33:53 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 24 WAITING Closing on EOF', > 'D [04/Jun/2012:07:33:53 -0500] cupsdCloseClient: 24', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 15 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 15 1.1 Get-Notifications 1', > 'D [04/Jun/2012:07:33:53 -0500] Get-Notifications /', > 'D [04/Jun/2012:07:33:53 -0500] cupsdIsAuthorized: requesting-user-name="root"', > 'D [04/Jun/2012:07:33:53 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Printers 1', > 'D [04/Jun/2012:07:33:53 -0500] CUPS-Get-Printers', > 'D [04/Jun/2012:07:33:53 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Classes 1', > 'D [04/Jun/2012:07:33:53 -0500] CUPS-Get-Classes', > 'D [04/Jun/2012:07:33:53 -0500] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:53 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:53 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Default 1', > 'D [04/Jun/2012:07:33:53 -0500] CUPS-Get-Default', > 'D [04/Jun/2012:07:33:53 -0500] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [04/Jun/2012:07:33:53 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:56 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:56 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:56 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:56 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:56 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:56 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:56 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:56 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Closing renderer', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] renderer exited with status 0', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] kid4 exited with status 0', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] kid3 finished', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] kid3 exited with status 0', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12]', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Closing foomatic-rip.', > 'D [04/Jun/2012:07:33:57 -0500] PID 21884 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 8192 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Read 7629 bytes of print data...', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Wrote 7629 bytes of print data...', > 'I [04/Jun/2012:07:33:57 -0500] [Job 12] Waiting for printer to finish.', > 'D [04/Jun/2012:07:33:57 -0500] [Job 12] Set job-printer-state-message to "Waiting for printer to finish.", current level=INFO', > 'D [04/Jun/2012:07:33:57 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdAcceptClient: skipping getpeercon()', > 'D [04/Jun/2012:07:33:57 -0500] cupsdAcceptClient: 24 from localhost (Domain)', > 'D [04/Jun/2012:07:33:57 -0500] cupsdReadClient: 24 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:57 -0500] cupsdReadClient: 24 1.1 Get-Notifications 1', > 'D [04/Jun/2012:07:33:57 -0500] Get-Notifications /', > 'D [04/Jun/2012:07:33:57 -0500] cupsdIsAuthorized: requesting-user-name="root"', > 'D [04/Jun/2012:07:33:57 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdReadClient: 24 WAITING Closing on EOF', > 'D [04/Jun/2012:07:33:57 -0500] cupsdCloseClient: 24', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdReadClient: 15 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:57 -0500] cupsdReadClient: 15 1.1 Get-Notifications 1', > 'D [04/Jun/2012:07:33:57 -0500] Get-Notifications /', > 'D [04/Jun/2012:07:33:57 -0500] cupsdIsAuthorized: requesting-user-name="root"', > 'D [04/Jun/2012:07:33:57 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:57 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Printers 1', > 'D [04/Jun/2012:07:33:57 -0500] CUPS-Get-Printers', > 'D [04/Jun/2012:07:33:57 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:57 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Classes 1', > 'D [04/Jun/2012:07:33:57 -0500] CUPS-Get-Classes', > 'D [04/Jun/2012:07:33:57 -0500] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:33:57 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:33:57 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Default 1', > 'D [04/Jun/2012:07:33:57 -0500] CUPS-Get-Default', > 'D [04/Jun/2012:07:33:57 -0500] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [04/Jun/2012:07:33:57 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [04/Jun/2012:07:33:59 -0500] [Job 12] Received 10 bytes of back-channel data', > 'D [04/Jun/2012:07:34:03 -0500] [Job 12] ATTR: marker-levels=-1,-1,-1,-1,-1', > 'D [04/Jun/2012:07:34:03 -0500] cupsdMarkDirty(P-----)', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] [Job 12] new_supply_state=0, change_state=0', > 'D [04/Jun/2012:07:34:03 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] [Job 12] new_state=0, change_state=0', > 'I [04/Jun/2012:07:34:03 -0500] [Job 12] Ready to print.', > 'D [04/Jun/2012:07:34:03 -0500] [Job 12] Set job-printer-state-message to "Ready to print.", current level=INFO', > 'D [04/Jun/2012:07:34:03 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] PID 21885 (/usr/lib/cups/backend/dnssd) exited with no errors.', > 'D [04/Jun/2012:07:34:03 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'I [04/Jun/2012:07:34:03 -0500] [Job 12] Job completed.', > 'D [04/Jun/2012:07:34:03 -0500] cupsdMarkDirty(----J-)', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdAcceptClient: skipping getpeercon()', > 'D [04/Jun/2012:07:34:03 -0500] cupsdAcceptClient: 21 from localhost (Domain)', > 'D [04/Jun/2012:07:34:03 -0500] cupsdReadClient: 21 POST / HTTP/1.1', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:34:03 -0500] cupsdReadClient: 21 1.1 Get-Notifications 1', > 'D [04/Jun/2012:07:34:03 -0500] Get-Notifications /', > 'D [04/Jun/2012:07:34:03 -0500] cupsdIsAuthorized: requesting-user-name="root"', > 'D [04/Jun/2012:07:34:03 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdReadClient: 21 WAITING Closing on EOF', > 'D [04/Jun/2012:07:34:03 -0500] cupsdCloseClient: 21', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdReadClient: 15 POST / HTTP/1.1', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:34:03 -0500] cupsdReadClient: 15 1.1 Get-Notifications 1', > 'D [04/Jun/2012:07:34:03 -0500] Get-Notifications /', > 'D [04/Jun/2012:07:34:03 -0500] cupsdIsAuthorized: requesting-user-name="root"', > 'D [04/Jun/2012:07:34:03 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:34:03 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Printers 1', > 'D [04/Jun/2012:07:34:03 -0500] CUPS-Get-Printers', > 'D [04/Jun/2012:07:34:03 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:34:03 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Classes 1', > 'D [04/Jun/2012:07:34:03 -0500] CUPS-Get-Classes', > 'D [04/Jun/2012:07:34:03 -0500] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdReadClient: 22 POST / HTTP/1.1', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:03 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:34:03 -0500] cupsdReadClient: 22 1.1 CUPS-Get-Default 1', > 'D [04/Jun/2012:07:34:03 -0500] CUPS-Get-Default', > 'D [04/Jun/2012:07:34:03 -0500] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [04/Jun/2012:07:34:03 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdReadClient: 15 POST / HTTP/1.1', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:34:04 -0500] [Job 12] Unloading...', > 'D [04/Jun/2012:07:34:04 -0500] cupsdReadClient: 15 1.1 Get-Job-Attributes 1', > 'D [04/Jun/2012:07:34:04 -0500] Get-Job-Attributes ipp://localhost/jobs/12', > 'D [04/Jun/2012:07:34:04 -0500] [Job 12] Loading attributes...', > 'D [04/Jun/2012:07:34:04 -0500] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/12) from localhost', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdReadClient: 15 POST / HTTP/1.1', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:34:04 -0500] cupsdReadClient: 15 1.1 Cancel-Subscription 1', > 'D [04/Jun/2012:07:34:04 -0500] Cancel-Subscription /', > 'D [04/Jun/2012:07:34:04 -0500] cupsdIsAuthorized: requesting-user-name="root"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdMarkDirty(-----S)', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] Returning IPP successful-ok for Cancel-Subscription (/) from localhost', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdReadClient: 15 PUT /admin/conf/cupsd.conf HTTP/1.1', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdAuthorize: No authentication data provided.', > 'D [04/Jun/2012:07:34:04 -0500] cupsdIsAuthorized: username=""', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSendHeader: 15 WWW-Authenticate: Basic realm="CUPS", trc="y"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdCloseClient: 15', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdAcceptClient: skipping getpeercon()', > 'D [04/Jun/2012:07:34:04 -0500] cupsdAcceptClient: 15 from localhost (Domain)', > 'D [04/Jun/2012:07:34:04 -0500] cupsdReadClient: 15 PUT /admin/conf/cupsd.conf HTTP/1.1', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdAuthorize: Authorized as root using PeerCred', > 'D [04/Jun/2012:07:34:04 -0500] cupsdIsAuthorized: username="root"', > 'I [04/Jun/2012:07:34:04 -0500] Installing config file "/etc/cups/cupsd.conf"...', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdCloseClient: 19', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdCloseClient: 23', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdCloseClient: 22', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdCloseClient: 15', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [04/Jun/2012:07:34:04 -0500] cupsdDeregisterPrinter(p=0x7f6ba0c46610(RICOH-Aficio-CL1000N), removeit=1)', > 'I [04/Jun/2012:07:34:04 -0500] Saving printers.conf...', > 'I [04/Jun/2012:07:34:04 -0500] Generating printcap /etc/printcap...', > 'I [04/Jun/2012:07:34:04 -0500] Saving job.cache...', > 'I [04/Jun/2012:07:34:04 -0500] Saving subscriptions.conf...', > 'D [04/Jun/2012:07:34:04 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"', > "W [04/Jun/2012:07:34:04 -0500] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'RICOH-Aficio-CL1000N-Gray..' already exists", > "W [04/Jun/2012:07:34:04 -0500] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'RICOH-Aficio-CL1000N-CMYK..' already exists", > "W [04/Jun/2012:07:34:04 -0500] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-RICOH-Aficio-CL1000N' already exists", > 'E [04/Jun/2012:07:34:04 -0500] Unable to bind socket for address [v1.::1]:631 - Address already in use.'], > 'error_log_debug_logging_unset': True} >Page 13 (Locale issues): >{'printer_page_size': u'Letter', > 'system_locale_lang': 'en_US', > 'user_locale_ctype': 'en_US', > 'user_locale_messages': 'en_US'}
You cannot view the attachment while viewing its details because your browser does not support IFRAMEs.
View the attachment on a separate page
.
View Attachment As Raw
Actions:
View
Attachments on
bug 827632
:
588593
| 589139 |
589141
|
589142
|
589177
|
589178
|
593265