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 913174 Details for
Bug 1114273
Canon Printer stopped printing abrubtly. stuck at > Printer state: Processing - Sending data to printer
[?]
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.
troubleshoot.txt
troubleshoot.txt (text/plain), 110.10 KB, created by
saurabh3679
on 2014-06-29 13:10:10 UTC
(
hide
)
Description:
troubleshoot.txt
Filename:
MIME Type:
Creator:
saurabh3679
Created:
2014-06-29 13:10:10 UTC
Size:
110.10 KB
patch
obsolete
>Page 1 (Scheduler not running?): >{'cups_connection_failure': False} >Page 2 (Choose printer): >{'cups_dest': <cups.Dest LBP2900 (default)>, > 'cups_instance': None, > 'cups_queue': u'LBP2900', > 'cups_queue_listed': True} >Page 3 (Check printer sanity): >{'cups_device_uri_scheme': u'usb', > 'cups_printer_dict': {'device-uri': u'usb://Canon/LBP2900?serial=0000A2BASIRk', > 'printer-info': u'Canon LBP2900', > 'printer-is-shared': False, > 'printer-location': u'Saurabh', > 'printer-make-and-model': u'Canon LBP2900 CAPT ver.1.5', > 'printer-state': 3, > 'printer-state-message': u'', > 'printer-state-reasons': [u'none'], > 'printer-type': 10621060, > 'printer-uri-supported': u'ipp://localhost:631/printers/LBP2900'}, > 'cups_printer_remote': False, > 'is_cups_class': False, > 'local_cups_queue_attributes': {'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.7.3', > 'device-uri': u'usb://Canon/LBP2900?serial=0000A2BASIRk', > 'document-format-default': u'application/octet-stream', > 'document-format-supported': [u'application/octet-stream', > u'application/pdf', > u'application/postscript', > u'application/vnd.adobe-reader-postscript', > u'application/vnd.cups-command', > u'application/vnd.cups-pdf', > u'application/vnd.cups-pdf-banner', > 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'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'orientation-requested', > u'page-ranges', > u'print-color-mode', > 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, 50542260), > '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'orientation-requested', > u'page-ranges', > u'print-color-mode', > 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'form', > u'secret', > u'standard', > u'topsecret', > u'unclassified'], > 'jpeg-k-octets-supported': (0, 50542260), > 'jpeg-x-dimension-supported': (0, 65535), > 'jpeg-y-dimension-supported': (1, 65535), > 'marker-change-time': 0, > 'media-bottom-margin-supported': [500, 999], > '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': [500, 999], > 'media-right-margin-supported': [500, > 999, > 1000], > 'media-source-supported': [u'0'], > 'media-supported': [u'na_letter_8.5x11in', > u'na_legal_8.5x14in', > u'na_executive_7.25x10.5in', > u'iso_a5_148x210mm', > u'jis_b5_182x257mm', > u'iso_a4_210x297mm', > u'om_com-10_104.78x241.3mm', > u'om_dl-envelope_110.07x220.13mm', > u'om_envelope-c-5_161.93x228.95mm', > u'om_monarch_98.43x190.5mm', > u'oe_index--3x-5_3x5in'], > 'media-top-margin-supported': [500, > 999, > 1000], > 'media-type-supported': [u'stationery', > u'stationery', > u'thick-paper', > u'thick-paper-h', > u'ohp', > u'envelope'], > '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, > 14], > 'orientation-requested-default': None, > 'orientation-requested-supported': [3, > 4, > 5, > 6], > 'output-bin-default': u'face-down', > 'output-bin-supported': [u'face-down'], > 'page-ranges-supported': True, > 'pages-per-minute': 12, > 'pdf-k-octets-supported': (0, 50542260), > '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'monochrome', > 'print-color-mode-supported': [u'monochrome'], > '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'abort-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/LBP2900.png', > 'printer-info': u'Canon LBP2900', > 'printer-is-accepting-jobs': True, > 'printer-is-shared': False, > 'printer-location': u'Saurabh', > 'printer-make-and-model': u'Canon LBP2900 CAPT ver.1.5', > 'printer-more-info': u'http://localhost:631/printers/LBP2900', > 'printer-name': u'LBP2900', > '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': 1404044088, > 'printer-state-message': u'', > 'printer-state-reasons': [u'none'], > 'printer-type': 10621060, > 'printer-up-time': 1404044353, > 'printer-uri-supported': [u'ipp://localhost:631/printers/LBP2900'], > 'printer-uuid': u'urn:uuid:4430e5b9-644b-3667-598a-de412c533649', > '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 4 (Check PPD sanity): >{'cups_printer_ppd_defaults': {u'General': {u'BitsPerPixel': u'8', > u'CNHalftone': u'pattern1', > u'CNSuperSmooth': u'True', > u'CNTonerDensity': u'3', > u'CNTonerSaving': u'False', > u'Collate': u'False', > u'InputSlot': u'0', > u'MediaType': u'PlainPaper', > u'PageRegion': u'Letter', > u'PageSize': u'Letter', > u'Resolution': u'600'}}, > 'cups_printer_ppd_valid': True, > 'missing_pkgs_and_exes': ([], [])} >Page 5 (Local or remote?): >{'printer_is_remote': False} >Page 6 (Choose device): >{'cups_device_dict': {'device-class': 'direct', > 'device-id': 'MFG:Canon;MDL:LBP2900;CMD:CAPT;VER:2.1;CLS:PRINTER;DES:Canon LBP2900', > 'device-info': 'Canon LBP2900', > 'device-make-and-model': 'Canon LBP2900'}} >Page 7 (Verify packages): >{'packages_verification': {'cups': ['..?...... /etc/cups/cupsd.conf.default', > '.M....... c /etc/cups/subscriptions.conf', > '..?...... /usr/lib/cups/backend/dnssd', > '..?...... /usr/lib/cups/backend/ipp', > '..?...... /usr/lib/cups/backend/lpd', > 'missing /var/spool/cups/tmp (Permission denied)'], > 'foomatic': ['package foomatic is not installed'], > 'gutenprint': [], > 'hpijs': ['package hpijs is not installed'], > 'hplip': ['package hplip is not installed'], > 'system-config-printer': []}} >Page 8 (Error log checkpoint): >{'cups_server_settings': {'BrowseLocalProtocols': 'dnssd', > 'DefaultAuthType': 'Basic', > 'JobPrivateAccess': 'default', > 'JobPrivateValues': 'default', > 'MaxLogSize': '0', > 'SubscriptionPrivateAccess': 'default', > 'SubscriptionPrivateValues': 'default', > 'WebInterface': 'Yes', > '_debug_logging': '0', > '_remote_admin': '0', > '_remote_any': '0', > '_share_printers': '0', > '_user_cancel_any': '0'}, > 'error_log_checkpoint': 28128L, > 'error_log_debug_logging_set': True} >Page 9 (Print test page): >{'test_page_attempted': '29/Jun/2014:17:50:06 +0000', > 'test_page_completions': [(522, u'Job canceled by "saurabh"')], > 'test_page_job_id': [522], > 'test_page_job_status': [(True, > 522, > 'LBP2900', > 'Test Page', > 'Canceled', > {'attributes-charset': u'utf-8', > 'attributes-natural-language': u'en-us', > 'document-format': u'application/vnd.cups-pdf-banner', > 'job-hold-until': u'no-hold', > 'job-id': 522, > 'job-k-octets': 1, > 'job-media-progress': 0, > 'job-media-sheets-completed': 0, > 'job-more-info': u'http://localhost:631/jobs/522', > 'job-preserved': True, > 'job-printer-state-message': u'Sending data to printer.', > 'job-printer-state-reasons': [u'none'], > 'job-printer-up-time': 1404044486, > 'job-printer-uri': u'ipp://localhost:631/printers/LBP2900', > 'job-priority': 50, > 'job-sheets': [u'none', u'none'], > 'job-state': 7, > 'job-state-reasons': u'processing-to-stop-point', > 'job-uri': u'ipp://localhost:631/jobs/522', > 'job-uuid': u'urn:uuid:3ae5095c-9270-35c3-6871-d6e68455e0d1', > 'number-of-documents': 1, > 'printer-uri': u'ipp://localhost/printers/LBP2900', > 'time-at-completed': 1404044483, > 'time-at-creation': 1404044406, > 'time-at-processing': 1404044406})], > 'test_page_jobs_cancelled': True, > 'test_page_successful': False} >Page 10 (Error log fetch): >{'error_log': ['D [29/Jun/2014:17:49:56 +0530] [Client 14] Sending file.', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=28128, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=26080, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=24032, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=21984, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=19936, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=17888, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=15840, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=13792, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=11744, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=9696, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=7648, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=5600, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=3552, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1504, response=(nil)(), pipe_pid=0, file=16', > 'D [29/Jun/2014:17:49:56 +0530] [Client 14] Waiting for request.', > 'D [29/Jun/2014:17:49:56 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] POST / HTTP/1.1', > 'D [29/Jun/2014:17:49:56 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] No authentication data provided.', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] 1.1 Get-Jobs 33', > 'D [29/Jun/2014:17:49:56 +0530] Get-Jobs ipp://localhost/printers/', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Content-Length: 75', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0xb8184480(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Waiting for request.', > 'D [29/Jun/2014:17:49:56 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] POST / HTTP/1.1', > 'D [29/Jun/2014:17:49:56 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] No authentication data provided.', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] 1.1 Get-Jobs 34', > 'D [29/Jun/2014:17:49:56 +0530] Get-Jobs ipp://localhost/printers/', > 'D [29/Jun/2014:17:49:56 +0530] [Job 519] Loading attributes...', > 'D [29/Jun/2014:17:49:56 +0530] [Job 520] Loading attributes...', > 'D [29/Jun/2014:17:49:56 +0530] [Job 521] Loading attributes...', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Content-Length: 345', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=345, response=0xb81cbdf8(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Waiting for request.', > 'D [29/Jun/2014:17:49:56 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] POST / HTTP/1.1', > 'D [29/Jun/2014:17:49:56 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] No authentication data provided.', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] 1.1 Create-Printer-Subscriptions 35', > 'D [29/Jun/2014:17:49:56 +0530] Create-Printer-Subscriptions /', > 'D [29/Jun/2014:17:49:56 +0530] create_subscriptions(con=0xb817eba0(15), uri="/")', > 'D [29/Jun/2014:17:49:56 +0530] pullmethod="ippget"', > 'D [29/Jun/2014:17:49:56 +0530] notify-lease-duration=86400', > 'D [29/Jun/2014:17:49:56 +0530] notify-time-interval=0', > 'D [29/Jun/2014:17:49:56 +0530] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")', > 'D [29/Jun/2014:17:49:56 +0530] Added subscription #49 for server.', > 'D [29/Jun/2014:17:49:56 +0530] cupsdMarkDirty(----S)', > 'D [29/Jun/2014:17:49:56 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Returning IPP successful-ok for Create-Printer-Subscriptions (/) from localhost', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Content-Length: 107', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=107, response=0xb8184480(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:49:56 +0530] [Client 15] Waiting for request.', > 'D [29/Jun/2014:17:49:56 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:49:58 +0530] [Client 15] POST / HTTP/1.1', > 'D [29/Jun/2014:17:49:58 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [29/Jun/2014:17:49:58 +0530] [Client 15] No authentication data provided.', > 'D [29/Jun/2014:17:49:58 +0530] [Client 15] 1.1 Get-Notifications 36', > 'D [29/Jun/2014:17:49:58 +0530] Get-Notifications /', > 'D [29/Jun/2014:17:49:58 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:49:58 +0530] [Client 15] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [29/Jun/2014:17:49:58 +0530] [Client 15] Content-Length: 127', > 'D [29/Jun/2014:17:49:58 +0530] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=127, response=0xb81cbdf8(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:49:58 +0530] [Client 15] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:49:58 +0530] [Client 15] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:49:58 +0530] [Client 15] Waiting for request.', > 'D [29/Jun/2014:17:49:58 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:50:06 +0530] [Client 16] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:50:06 +0530] [Client 16] Waiting for request.', > 'D [29/Jun/2014:17:50:06 +0530] [Client 16] POST /printers/LBP2900 HTTP/1.1', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] [Client 16] No authentication data provided.', > 'D [29/Jun/2014:17:50:06 +0530] [Client 16] 1.1 Print-Job 37', > 'D [29/Jun/2014:17:50:06 +0530] Print-Job ipp://localhost/printers/LBP2900', > 'D [29/Jun/2014:17:50:06 +0530] [Job ???] Auto-typing file...', > 'I [29/Jun/2014:17:50:06 +0530] [Job ???] Request file type is application/vnd.cups-pdf-banner.', > 'D [29/Jun/2014:17:50:06 +0530] add_job: setting context of job to UNKNOWN SL', > 'D [29/Jun/2014:17:50:06 +0530] cupsdMarkDirty(---J-)', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] add_job: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:50:06 +0530] Adding default job-sheets values "none,none"...', > 'I [29/Jun/2014:17:50:06 +0530] [Job 522] Adding start banner page "none".', > 'D [29/Jun/2014:17:50:06 +0530] Notifier dbus started - PID = 4929', > 'D [29/Jun/2014:17:50:06 +0530] cupsdMarkDirty(----S)', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] cupsdMarkDirty(---J-)', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'I [29/Jun/2014:17:50:06 +0530] [Job 522] Adding end banner page "none".', > 'I [29/Jun/2014:17:50:06 +0530] [Job 522] File of type application/vnd.cups-pdf-banner queued by "saurabh".', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] hold_until=0', > 'I [29/Jun/2014:17:50:06 +0530] [Job 522] Queued on "LBP2900" by "saurabh".', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] time-at-processing=1404044406', > 'D [29/Jun/2014:17:50:06 +0530] cupsdMarkDirty(---J-)', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] cupsdMarkDirty(----S)', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] 4 filters for job:', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] bannertopdf (application/vnd.cups-pdf-banner to application/pdf, cost 32)', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] pdftops (application/vnd.cups-pdf to application/vnd.cups-postscript, cost 100)', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] pstocapt (application/vnd.cups-postscript to printer/LBP2900, cost 0)', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] job-sheets=none,none', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] argv[0]="LBP2900"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] argv[1]="522"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] argv[2]="saurabh"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] argv[3]="Test Page"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] argv[4]="1"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] argv[5]="job-uuid=urn:uuid:3ae5095c-9270-35c3-6871-d6e68455e0d1 job-originating-host-name=localhost time-at-creation=1404044406 time-at-processing=1404044406"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] argv[6]="/var/spool/cups/d00522-001"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[0]="CUPS_CACHEDIR=/var/cache/cups"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[1]="CUPS_DATADIR=/usr/share/cups"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[6]="CUPS_SERVERROOT=/etc/cups"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[7]="CUPS_STATEDIR=/var/run/cups"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[8]="HOME=/var/spool/cups/tmp"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[10]="SERVER_ADMIN=root@Saurabh"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[11]="SOFTWARE=CUPS/1.7.3"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[12]="TMPDIR=/var/spool/cups/tmp"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[13]="USER=root"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[14]="CUPS_MAX_MESSAGE=2047"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[16]="CUPS_ENCRYPTION=IfRequested"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[17]="IPP_PORT=631"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[18]="CHARSET=utf-8"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[19]="LANG=en_US.UTF-8"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[20]="PPD=/etc/cups/ppd/LBP2900.ppd"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[21]="RIP_MAX_CACHE=128m"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf-banner"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[23]="DEVICE_URI=usb://Canon/LBP2900?serial=0000A2BASIRk"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[24]="PRINTER_INFO=Canon LBP2900"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[25]="PRINTER_LOCATION=Saurabh"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[26]="PRINTER=LBP2900"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[27]="PRINTER_STATE_REASONS=none"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[28]="CUPS_FILETYPE=document"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[29]="FINAL_CONTENT_TYPE=printer/LBP2900"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] envp[30]="AUTH_I****"', > 'I [29/Jun/2014:17:50:06 +0530] [Job 522] Started filter /usr/lib/cups/filter/bannertopdf (PID 4930)', > 'I [29/Jun/2014:17:50:06 +0530] [Job 522] Started filter /usr/lib/cups/filter/pdftopdf (PID 4931)', > 'I [29/Jun/2014:17:50:06 +0530] [Job 522] Started filter /usr/lib/cups/filter/pdftops (PID 4932)', > 'I [29/Jun/2014:17:50:06 +0530] [Job 522] Started filter /usr/lib/cups/filter/pstocapt (PID 4933)', > 'I [29/Jun/2014:17:50:06 +0530] [Job 522] Started backend /usr/lib/cups/backend/usb (PID 4934)', > 'D [29/Jun/2014:17:50:06 +0530] cupsdMarkDirty(----S)', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] [Client 16] Returning IPP successful-ok for Print-Job (ipp://localhost/printers/LBP2900) from localhost', > 'D [29/Jun/2014:17:50:06 +0530] [Client 16] Content-Length: 175', > 'D [29/Jun/2014:17:50:06 +0530] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=175, response=0xb81cb7f0(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:06 +0530] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:06 +0530] [Client 16] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:06 +0530] [Client 16] Waiting for request.', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] pstocapt start.', > 'D [29/Jun/2014:17:50:06 +0530] [Notifier] state=3', > 'D [29/Jun/2014:17:50:06 +0530] [Notifier] Connected to D-BUS', > 'D [29/Jun/2014:17:50:06 +0530] [Notifier] JobCreated', > 'D [29/Jun/2014:17:50:06 +0530] [Notifier] state=3', > 'D [29/Jun/2014:17:50:06 +0530] [Notifier] PrinterStateChanged', > 'D [29/Jun/2014:17:50:06 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:50:06 +0530] [Client 21] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:50:06 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:06 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:06 +0530] [Client 21] 1.1 Get-Notifications 146', > 'D [29/Jun/2014:17:50:06 +0530] Get-Notifications /printers/', > 'D [29/Jun/2014:17:50:06 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:50:06 +0530] [Client 21] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost', > 'D [29/Jun/2014:17:50:06 +0530] [Client 21] Content-Length: 1547', > 'D [29/Jun/2014:17:50:06 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1547, response=0xb8183508(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:06 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:06 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:06 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] [Notifier] state=3', > 'D [29/Jun/2014:17:50:06 +0530] [Notifier] JobState', > 'D [29/Jun/2014:17:50:06 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:50:06 +0530] [Client 22] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:50:06 +0530] [Client 22] Waiting for request.', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] pdftops - copying to temp print file "/var/spool/cups/tmp/cupslbItoK"', > 'D [29/Jun/2014:17:50:06 +0530] [Client 22] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] [Client 22] No authentication data provided.', > 'D [29/Jun/2014:17:50:06 +0530] [Client 22] 1.1 Get-Job-Attributes 147', > 'D [29/Jun/2014:17:50:06 +0530] Get-Job-Attributes ipp://localhost/jobs/522', > 'D [29/Jun/2014:17:50:06 +0530] [Client 22] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/522) from localhost', > 'D [29/Jun/2014:17:50:06 +0530] [Client 22] Content-Length: 113', > 'D [29/Jun/2014:17:50:06 +0530] [Client 22] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0xb81854b8(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:06 +0530] [Client 22] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:06 +0530] [Client 22] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:06 +0530] [Client 22] Waiting for request.', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:50:06 +0530] [Client 23] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:50:06 +0530] [Client 23] Waiting for request.', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] Loading USB quirks from "/usr/share/cups/usb".', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] Loaded 68 quirks.', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] Printing on printer with URI: usb://Canon/LBP2900?serial=0000A2BASIRk', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] libusb_get_device_list=10', > 'D [29/Jun/2014:17:50:06 +0530] [Job 522] STATE: +connecting-to-device', > 'D [29/Jun/2014:17:50:06 +0530] cupsdMarkDirty(---J-)', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] cupsdMarkDirty(----S)', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] [Client 23] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:06 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [29/Jun/2014:17:50:06 +0530] [Client 23] No authentication data provided.', > 'D [29/Jun/2014:17:50:06 +0530] [Client 23] 1.1 Get-Job-Attributes 148', > 'D [29/Jun/2014:17:50:06 +0530] Get-Job-Attributes ipp://localhost/jobs/522', > 'D [29/Jun/2014:17:50:07 +0530] [Client 23] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/522) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 23] Content-Length: 113', > 'D [29/Jun/2014:17:50:07 +0530] [Client 23] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0xb8183950(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 23] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 23] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 23] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Notifier] state=3', > 'D [29/Jun/2014:17:50:07 +0530] [Notifier] PrinterStateChanged', > 'D [29/Jun/2014:17:50:07 +0530] [Job 522] STATE: -connecting-to-device', > 'D [29/Jun/2014:17:50:07 +0530] cupsdMarkDirty(---J-)', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] cupsdMarkDirty(----S)', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Notifier] state=3', > 'D [29/Jun/2014:17:50:07 +0530] [Notifier] PrinterStateChanged', > 'D [29/Jun/2014:17:50:07 +0530] [Job 522] Device protocol: 2', > 'I [29/Jun/2014:17:50:07 +0530] [Job 522] Sending data to printer.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdMarkDirty(---J-)', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Job 522] Set job-printer-state-message to "Sending data to printer.", current level=INFO', > 'D [29/Jun/2014:17:50:07 +0530] cupsdMarkDirty(----S)', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] cupsdMarkDirty(----S)', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] 1.1 Get-Notifications 149', > 'D [29/Jun/2014:17:50:07 +0530] Get-Notifications /printers/', > 'D [29/Jun/2014:17:50:07 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Content-Length: 1346', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1346, response=0xb81e1960(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] 1.1 CUPS-Get-Printers 150', > 'D [29/Jun/2014:17:50:07 +0530] CUPS-Get-Printers', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Content-Length: 1123', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1123, response=0xb81e2318(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Notifier] state=3', > 'D [29/Jun/2014:17:50:07 +0530] [Notifier] PrinterStateChanged', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] 1.1 CUPS-Get-Default 151', > 'D [29/Jun/2014:17:50:07 +0530] CUPS-Get-Default', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Content-Length: 7185', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=7185, response=0xb81e1960(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] 1.1 CUPS-Get-Printers 152', > 'D [29/Jun/2014:17:50:07 +0530] CUPS-Get-Printers', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Content-Length: 1123', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1123, response=0xb81e2318(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] 1.1 CUPS-Get-Default 153', > 'D [29/Jun/2014:17:50:07 +0530] CUPS-Get-Default', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Content-Length: 7185', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=7185, response=0xb81e1960(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] 1.1 CUPS-Get-Printers 154', > 'D [29/Jun/2014:17:50:07 +0530] CUPS-Get-Printers', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Content-Length: 1123', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1123, response=0xb81e1780(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] 1.1 CUPS-Get-Default 155', > 'D [29/Jun/2014:17:50:07 +0530] CUPS-Get-Default', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Content-Length: 7185', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=7185, response=0xb81e1960(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] 1.1 Get-Notifications 156', > 'D [29/Jun/2014:17:50:07 +0530] Get-Notifications /printers/', > 'D [29/Jun/2014:17:50:07 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Content-Length: 127', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=127, response=0xb81e18e0(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] 1.1 Get-Notifications 157', > 'D [29/Jun/2014:17:50:07 +0530] Get-Notifications /printers/', > 'D [29/Jun/2014:17:50:07 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Content-Length: 127', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=127, response=0xb81e1960(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] 1.1 Get-Notifications 158', > 'D [29/Jun/2014:17:50:07 +0530] Get-Notifications /printers/', > 'D [29/Jun/2014:17:50:07 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Content-Length: 127', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=127, response=0xb81e18e0(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] 1.1 Get-Notifications 159', > 'D [29/Jun/2014:17:50:07 +0530] Get-Notifications /printers/', > 'D [29/Jun/2014:17:50:07 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Content-Length: 127', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=127, response=0xb81e1960(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > "D [29/Jun/2014:17:50:07 +0530] [Job 522] PDF template file doesn't have form. It's okay.", > 'D [29/Jun/2014:17:50:07 +0530] [Job 522] PID 4930 (/usr/lib/cups/filter/bannertopdf) exited with no errors.', > 'D [29/Jun/2014:17:50:07 +0530] [Job 522] Printer make and model: Canon LBP2900', > "D [29/Jun/2014:17:50:07 +0530] [Job 522] Running command line for pstops: pstops 522 saurabh 'Test Page' 1 'job-uuid=urn:uuid:3ae5095c-9270-35c3-6871-d6e68455e0d1 job-originating-host-name=localhost time-at-creation=1404044406 time-at-processing=1404044406'", > 'D [29/Jun/2014:17:50:07 +0530] [Job 522] Using image rendering resolution 600 dpi', > "D [29/Jun/2014:17:50:07 +0530] [Job 522] Running command line for gs: gs -q -dNOPAUSE -dBATCH -dSAFER -sDEVICE=ps2write -sOUTPUTFILE=%stdout -dLanguageLevel=3 -r600 -dCompressFonts=false -dNoT3CCITT -dNOINTERPOLATE -c 'save pop' -f /var/spool/cups/tmp/cupslbItoK", > 'D [29/Jun/2014:17:50:07 +0530] [Job 522] Started filter gs (PID 4940)', > 'D [29/Jun/2014:17:50:07 +0530] [Job 522] Started filter pstops (PID 4941)', > 'D [29/Jun/2014:17:50:07 +0530] [Job 522] PID 4931 (/usr/lib/cups/filter/pdftopdf) exited with no errors.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] 1.1 Get-Notifications 38', > 'D [29/Jun/2014:17:50:07 +0530] Get-Notifications /', > 'D [29/Jun/2014:17:50:07 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Content-Length: 1761', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1761, response=0xb81e1848(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:50:07 +0530] [Client 25] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:50:07 +0530] [Client 25] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] HTTP_STATE_WAITING Closing on EOF', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Closing connection.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 15] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 15] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 15] 1.1 Get-Notifications 39', > 'D [29/Jun/2014:17:50:07 +0530] Get-Notifications /', > 'D [29/Jun/2014:17:50:07 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 15] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 15] Content-Length: 1646', > 'D [29/Jun/2014:17:50:07 +0530] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1646, response=0xb81e1870(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 15] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 15] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 15] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] 1.1 CUPS-Get-Printers 40', > 'D [29/Jun/2014:17:50:07 +0530] CUPS-Get-Printers', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Content-Length: 473', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=473, response=0xb81e1938(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] 1.1 CUPS-Get-Classes 41', > 'D [29/Jun/2014:17:50:07 +0530] CUPS-Get-Classes', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Content-Length: 75', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0xb8182fd0(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] POST / HTTP/1.1', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] No authentication data provided.', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] 1.1 CUPS-Get-Default 42', > 'D [29/Jun/2014:17:50:07 +0530] CUPS-Get-Default', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Content-Length: 7185', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=7185, response=0xb81e1938(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:50:07 +0530] [Client 24] Waiting for request.', > 'D [29/Jun/2014:17:50:07 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] Page = 612x792; 14,14 to 598,778', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] slow_collate=0, slow_duplex=0, slow_order=0', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] Before copy_comments - %!PS-Adobe-3.0', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] %!PS-Adobe-3.0', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] %%BoundingBox: 0 0 612 792', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] %%HiResBoundingBox: 0 0 612.00 792.00', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] %%Creator: GPL Ghostscript 914 (ps2write)', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] %%LanguageLevel: 2', > "D [29/Jun/2014:17:50:16 +0530] [Job 522] %%CreationDate: D:20140629175007+05'30'", > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] %%Pages: 1', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] %%EndComments', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] Before copy_prolog - %%BeginProlog', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] Before copy_setup - %%Page: 1 1', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] Before page loop - %%Page: 1 1', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] Copying page 1...', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] pagew = 583.7, pagel = 763.7', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] PageLeft = 14.2, PageRight = 597.8', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] PageTop = 777.8, PageBottom = 14.2', > 'D [29/Jun/2014:17:50:16 +0530] [Job 522] PageWidth = 612.0, PageLength = 792.0', > 'I [29/Jun/2014:17:50:20 +0530] Generating printcap /etc/printcap...', > 'I [29/Jun/2014:17:50:20 +0530] Saving job.cache...', > 'I [29/Jun/2014:17:50:21 +0530] Saving subscriptions.conf...', > 'D [29/Jun/2014:17:50:21 +0530] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] PID 4932 (/usr/lib/cups/filter/pdftops) exited with no errors.', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] PID 4940 (gs) exited with no errors.', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 1 pages...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] PID 4941 (pstops) exited with no errors.', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 212 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 212 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 240 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 240 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 288 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 288 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 1612 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 1612 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 1264 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 1264 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 1448 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 1448 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 352 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 352 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 236 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 920 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Wrote 920 bytes of print data...', > 'D [29/Jun/2014:17:50:21 +0530] [Job 522] Read 2792 bytes of print data...', > 'D [29/Jun/2014:17:50:22 +0530] [Job 522] Wrote 2792 bytes of print data...', > 'D [29/Jun/2014:17:50:22 +0530] [Job 522] Read 3768 bytes of print data...', > 'D [29/Jun/2014:17:50:22 +0530] [Job 522] Wrote 3768 bytes of print data...', > 'D [29/Jun/2014:17:50:22 +0530] [Job 522] Read 8192 bytes of print data...', > 'D [29/Jun/2014:17:50:27 +0530] [Client 14] HTTP_STATE_WAITING Closing on EOF', > 'D [29/Jun/2014:17:50:27 +0530] [Client 14] Closing connection.', > 'D [29/Jun/2014:17:50:27 +0530] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [29/Jun/2014:17:51:07 +0530] [Job 522] Got USB transaction timeout during read.', > 'D [29/Jun/2014:17:51:07 +0530] [Job 519] Unloading...', > 'D [29/Jun/2014:17:51:07 +0530] [Job 520] Unloading...', > 'D [29/Jun/2014:17:51:07 +0530] [Job 521] Unloading...', > 'D [29/Jun/2014:17:51:07 +0530] Report: clients=7', > 'D [29/Jun/2014:17:51:07 +0530] Report: jobs=4', > 'D [29/Jun/2014:17:51:07 +0530] Report: jobs-active=1', > 'D [29/Jun/2014:17:51:07 +0530] Report: printers=1', > 'D [29/Jun/2014:17:51:07 +0530] Report: stringpool-string-count=1885', > 'D [29/Jun/2014:17:51:07 +0530] Report: stringpool-alloc-bytes=10248', > 'D [29/Jun/2014:17:51:07 +0530] Report: stringpool-total-bytes=34472', > 'D [29/Jun/2014:17:51:07 +0530] [Client 15] POST / HTTP/1.1', > 'D [29/Jun/2014:17:51:07 +0530] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [29/Jun/2014:17:51:07 +0530] [Client 15] No authentication data provided.', > 'D [29/Jun/2014:17:51:07 +0530] [Client 15] 1.1 Get-Notifications 43', > 'D [29/Jun/2014:17:51:07 +0530] Get-Notifications /', > 'D [29/Jun/2014:17:51:07 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:51:07 +0530] [Client 15] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [29/Jun/2014:17:51:07 +0530] [Client 15] Content-Length: 127', > 'D [29/Jun/2014:17:51:07 +0530] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=127, response=0xb81850f0(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:51:07 +0530] [Client 15] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:51:07 +0530] [Client 15] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:51:07 +0530] [Client 15] Waiting for request.', > 'D [29/Jun/2014:17:51:07 +0530] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [29/Jun/2014:17:51:22 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:51:22 +0530] [Client 14] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:51:22 +0530] [Client 14] Waiting for request.', > 'D [29/Jun/2014:17:51:22 +0530] [Client 14] POST / HTTP/1.1', > 'D [29/Jun/2014:17:51:22 +0530] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [29/Jun/2014:17:51:22 +0530] [Client 14] No authentication data provided.', > 'D [29/Jun/2014:17:51:22 +0530] [Client 14] 1.1 Get-Job-Attributes 1', > 'D [29/Jun/2014:17:51:22 +0530] Get-Job-Attributes ipp://localhost/jobs/522', > 'D [29/Jun/2014:17:51:22 +0530] [Client 14] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/522) from localhost', > 'D [29/Jun/2014:17:51:22 +0530] [Client 14] Content-Length: 113', > 'D [29/Jun/2014:17:51:22 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0xb81c59c8(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:51:22 +0530] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:51:22 +0530] [Client 14] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:51:22 +0530] [Client 14] Waiting for request.', > 'D [29/Jun/2014:17:51:22 +0530] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [29/Jun/2014:17:51:23 +0530] [Client 14] POST /jobs/ HTTP/1.1', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [29/Jun/2014:17:51:23 +0530] [Client 14] No authentication data provided.', > 'D [29/Jun/2014:17:51:23 +0530] [Client 14] 1.1 Cancel-Job 2', > 'D [29/Jun/2014:17:51:23 +0530] Cancel-Job ipp://localhost/jobs/522', > 'D [29/Jun/2014:17:51:23 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:51:23 +0530] [Job 522] time-at-completed=1404044483', > 'D [29/Jun/2014:17:51:23 +0530] cupsdMarkDirty(----S)', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and printing jobs"', > 'I [29/Jun/2014:17:51:23 +0530] [Job 522] Job canceled by "saurabh"', > 'D [29/Jun/2014:17:51:23 +0530] cupsdMarkDirty(---J-)', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'I [29/Jun/2014:17:51:23 +0530] [Job 522] Canceled by "saurabh".', > 'D [29/Jun/2014:17:51:23 +0530] [Client 14] Returning IPP successful-ok for Cancel-Job (ipp://localhost/jobs/522) from localhost', > 'D [29/Jun/2014:17:51:23 +0530] [Client 14] Content-Length: 75', > 'D [29/Jun/2014:17:51:23 +0530] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0xb819a950(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:51:23 +0530] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:51:23 +0530] [Client 14] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:51:23 +0530] [Client 14] Waiting for request.', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:51:23 +0530] [Job 522] PID 4933 (/usr/lib/cups/filter/pstocapt) exited with no errors.', > 'D [29/Jun/2014:17:51:23 +0530] [Notifier] state=3', > 'D [29/Jun/2014:17:51:23 +0530] [Notifier] JobCompleted', > 'D [29/Jun/2014:17:51:23 +0530] [Client 21] POST / HTTP/1.1', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:23 +0530] [Client 21] No authentication data provided.', > 'D [29/Jun/2014:17:51:23 +0530] [Client 21] 1.1 Get-Notifications 160', > 'D [29/Jun/2014:17:51:23 +0530] Get-Notifications /printers/', > 'D [29/Jun/2014:17:51:23 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:51:23 +0530] [Client 21] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost', > 'D [29/Jun/2014:17:51:23 +0530] [Client 21] Content-Length: 651', > 'D [29/Jun/2014:17:51:23 +0530] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=651, response=0xb819a950(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:51:23 +0530] [Client 21] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:51:23 +0530] [Client 21] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:51:23 +0530] [Client 21] Waiting for request.', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:51:23 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:51:23 +0530] [Client 26] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:51:23 +0530] [Client 26] Waiting for request.', > 'D [29/Jun/2014:17:51:23 +0530] [Client 26] POST / HTTP/1.1', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:23 +0530] [Client 26] No authentication data provided.', > 'D [29/Jun/2014:17:51:23 +0530] [Client 26] 1.1 Get-Job-Attributes 161', > 'D [29/Jun/2014:17:51:23 +0530] Get-Job-Attributes ipp://localhost/jobs/522', > 'D [29/Jun/2014:17:51:23 +0530] [Client 26] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/522) from localhost', > 'D [29/Jun/2014:17:51:23 +0530] [Client 26] Content-Length: 113', > 'D [29/Jun/2014:17:51:23 +0530] [Client 26] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0xb8183048(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:51:23 +0530] [Client 26] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:51:23 +0530] [Client 26] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:51:23 +0530] [Client 26] Waiting for request.', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:51:23 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] Waiting for request.', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] POST / HTTP/1.1', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] No authentication data provided.', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] 1.1 Get-Notifications 44', > 'D [29/Jun/2014:17:51:23 +0530] Get-Notifications /', > 'D [29/Jun/2014:17:51:23 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] Content-Length: 127', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=127, response=0xb819a950(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] Waiting for request.', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] HTTP_STATE_WAITING Closing on EOF', > 'D [29/Jun/2014:17:51:23 +0530] [Client 27] Closing connection.', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:23 +0530] [Client 15] POST / HTTP/1.1', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:23 +0530] [Client 15] No authentication data provided.', > 'D [29/Jun/2014:17:51:23 +0530] [Client 15] 1.1 Get-Notifications 45', > 'D [29/Jun/2014:17:51:23 +0530] Get-Notifications /', > 'D [29/Jun/2014:17:51:23 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:51:23 +0530] [Client 15] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [29/Jun/2014:17:51:23 +0530] [Client 15] Content-Length: 651', > 'D [29/Jun/2014:17:51:23 +0530] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=651, response=0xb81c59c8(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:51:23 +0530] [Client 15] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:51:23 +0530] [Client 15] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:51:23 +0530] [Client 15] Waiting for request.', > 'D [29/Jun/2014:17:51:23 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] POST / HTTP/1.1', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] No authentication data provided.', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] 1.1 Get-Job-Attributes 46', > 'D [29/Jun/2014:17:51:26 +0530] Get-Job-Attributes ipp://localhost/jobs/522', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/522) from localhost', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] Content-Length: 854', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=854, response=0xb819a950(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] Waiting for request.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] POST / HTTP/1.1', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] No authentication data provided.', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] 1.1 Cancel-Subscription 47', > 'D [29/Jun/2014:17:51:26 +0530] Cancel-Subscription /', > 'D [29/Jun/2014:17:51:26 +0530] cupsdIsAuthorized: requesting-user-name="saurabh"', > 'D [29/Jun/2014:17:51:26 +0530] cupsdMarkDirty(----S)', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] Returning IPP successful-ok for Cancel-Subscription (/) from localhost', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] Content-Length: 75', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0xb81cba80(IPP_IDLE), pipe_pid=0, file=-1', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] bytes=0, http_state=0, data_remaining=0', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] Waiting for request.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] PUT /admin/conf/cupsd.conf HTTP/1.1', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] No authentication data provided.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdIsAuthorized: username=""', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] WWW-Authenticate: Basic realm="CUPS", trc="y"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] Waiting for request.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:51:26 +0530] [Client 27] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:51:26 +0530] [Client 27] Waiting for request.', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] HTTP_STATE_WAITING Closing on EOF', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] cupsdAcceptClient: skipping getpeercon()', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] Accepted from localhost (Domain)', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] Waiting for request.', > 'D [29/Jun/2014:17:51:26 +0530] [Client 27] HTTP_STATE_WAITING Closing on EOF', > 'D [29/Jun/2014:17:51:26 +0530] [Client 27] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] PUT /admin/conf/cupsd.conf HTTP/1.1', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] Authorized as root using PeerCred', > 'D [29/Jun/2014:17:51:26 +0530] cupsdIsAuthorized: username="root"', > 'I [29/Jun/2014:17:51:26 +0530] Installing config file "/etc/cups/cupsd.conf"...', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 15] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 16] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 21] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 22] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 23] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 25] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 24] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 26] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [29/Jun/2014:17:51:26 +0530] [Client 14] Closing connection.', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'I [29/Jun/2014:17:51:26 +0530] Saving job.cache...', > 'I [29/Jun/2014:17:51:26 +0530] Saving subscriptions.conf...', > 'D [29/Jun/2014:17:51:26 +0530] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs and dirty files"', > 'E [29/Jun/2014:17:51:26 +0530] Unknown directive JobPrivateAccess on line 84 of /etc/cups/cupsd.conf.', > 'E [29/Jun/2014:17:51:26 +0530] Unknown directive JobPrivateValues on line 85 of /etc/cups/cupsd.conf.', > 'E [29/Jun/2014:17:51:26 +0530] Unknown directive SubscriptionPrivateAccess on line 86 of /etc/cups/cupsd.conf.', > 'E [29/Jun/2014:17:51:26 +0530] Unknown directive SubscriptionPrivateValues on line 87 of /etc/cups/cupsd.conf.', > "W [29/Jun/2014:17:51:26 +0530] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'LBP2900-Gray..' already exists"], > 'error_log_debug_logging_unset': True} >Page 11 (Printer state reasons): >{'printer-state-message': u'Sending data to printer.', > 'printer-state-reasons': [u'none']} >Page 12 (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 1114273
: 913174