Attachment 787464 Details for Bug 998056 – print troubleshooter output

print troubleshooter output

troubleshootwithtestandnormal.txt (text/plain), 165.40 KB, created by Peter H. Jones on 2013-08-16 22:17:49 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Peter H. Jones

Created: 2013-08-16 22:17:49 UTC

Size: 165.40 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 Brother-HL-2040-series (default)>,
> 'cups_instance': None,
> 'cups_queue': 'Brother-HL-2040-series',
> 'cups_queue_listed': True}
>Page 4 (Check printer sanity):
>{'cups_device_uri_scheme': u'usb',
> 'cups_printer_dict': {'device-uri': u'usb://Brother/HL-2040%20series?serial=C5J556102',
>                       'printer-info': u'Brother HL-2040 series',
>                       'printer-is-shared': True,
>                       'printer-location': u'localhost.localdomain',
>                       'printer-make-and-model': u'Brother HL-2040 Foomatic/hl1250 (recommended)',
>                       'printer-state': 3,
>                       'printer-state-message': u'Sending data to printer.',
>                       'printer-state-reasons': [u'none'],
>                       'printer-type': 8564740,
>                       'printer-uri-supported': u'ipp://localhost:631/printers/Brother-HL-2040-series'},
> '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.5.4',
>                                 'device-uri': u'usb://Brother/HL-2040%20series?serial=C5J556102',
>                                 '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, 26191740),
>                                 '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, 26191740),
>                                 'jpeg-x-dimension-supported': (0, 65535),
>                                 'jpeg-y-dimension-supported': (1, 65535),
>                                 'marker-change-time': 0,
>                                 'media-bottom-margin-supported': [1270],
>                                 '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': [635],
>                                 'media-right-margin-supported': [635],
>                                 'media-source-supported': [u'top',
>                                                            u'bottom',
>                                                            u'auto',
>                                                            u'dual',
>                                                            u'manual'],
>                                 'media-supported': [u'na_letter_8.5x11in',
>                                                     u'iso_a4_210x297mm',
>                                                     u'oe_11x17in_11x17in',
>                                                     u'iso_a3_297x420mm',
>                                                     u'iso_a5_148x210mm',
>                                                     u'jis_b5_182x257mm',
>                                                     u'na_number-10_4.125x9.5in',
>                                                     u'iso_c5_162x229mm',
>                                                     u'iso_dl_110x220mm',
>                                                     u'om_env-isob5_176.04x250.12mm',
>                                                     u'na_monarch_3.875x7.5in',
>                                                     u'na_executive_7.25x10.5in',
>                                                     u'na_legal_8.5x14in',
>                                                     u'custom_min_0.5x0.5in',
>                                                     u'custom_max_35277.779999x35277.779999mm'],
>                                 'media-top-margin-supported': [1270],
>                                 'media-type-supported': [u'stationery',
>                                                          u'thick',
>                                                          u'thicker',
>                                                          u'thin',
>                                                          u'transparency'],
>                                 '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'monochrome',
>                                 'output-mode-supported': [u'monochrome'],
>                                 'page-ranges-supported': True,
>                                 'pages-per-minute': 1,
>                                 'pdf-k-octets-supported': (0, 26191740),
>                                 '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'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/Brother-HL-2040-series.png',
>                                 'printer-info': u'Brother HL-2040 series',
>                                 'printer-is-accepting-jobs': True,
>                                 'printer-is-shared': True,
>                                 'printer-location': u'localhost.localdomain',
>                                 'printer-make-and-model': u'Brother HL-2040 Foomatic/hl1250 (recommended)',
>                                 'printer-more-info': u'http://localhost:631/printers/Brother-HL-2040-series',
>                                 'printer-name': u'Brother-HL-2040-series',
>                                 'printer-op-policy': u'default',
>                                 'printer-op-policy-supported': [u'authenticated',
>                                                                 u'default'],
>                                 'printer-resolution-default': (300, 300, 3),
>                                 'printer-resolution-supported': [(75,
>                                                                   75,
>                                                                   3),
>                                                                  (150,
>                                                                   150,
>                                                                   3),
>                                                                  (300,
>                                                                   300,
>                                                                   3),
>                                                                  (600,
>                                                                   600,
>                                                                   3),
>                                                                  (1200,
>                                                                   600,
>                                                                   3)],
>                                 'printer-settable-attributes-supported': [u'printer-info',
>                                                                           u'printer-location'],
>                                 'printer-state': 3,
>                                 'printer-state-change-time': 1376690442,
>                                 'printer-state-message': u'Sending data to printer.',
>                                 'printer-state-reasons': [u'none'],
>                                 'printer-type': 8564740,
>                                 'printer-up-time': 1376690934,
>                                 'printer-uri-supported': [u'ipp://localhost:631/printers/Brother-HL-2040-series'],
>                                 'printer-uuid': u'urn:uuid:88f687cc-acd0-353f-6311-340d859cd8d6',
>                                 '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'EconoMode': u'off',
>                                            u'InputSlot': u'auto',
>                                            u'MediaType': u'plain',
>                                            u'PageRegion': u'Letter',
>                                            u'PageSize': u'Letter',
>                                            u'Resolution': u'300x300dpi'}},
> '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'direct',
>                      'device-id': u'MFG:Brother;CMD:PJL,HBP;MDL:HL-2040 series;CLS:PRINTER;',
>                      'device-info': u'Brother HL-2040 series',
>                      'device-location': u'',
>                      'device-make-and-model': u'Brother HL-2040 series'}}
>Page 8 (Printer state reasons):
>{'printer-state-message': u'Sending data to printer.',
> 'printer-state-reasons': [u'none']}
>Page 9 (Verify packages):
>{'packages_verification': {'cups': ['.M.......  c /etc/cups/subscriptions.conf'],
>                           'foomatic': [],
>                           'gutenprint': [],
>                           'hpijs': [],
>                           'hplip': ['missing     /var/run/hplip'],
>                           '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',
>                          'WebInterface': 'Yes',
>                          '_debug_logging': '0',
>                          '_remote_admin': '0',
>                          '_remote_any': '0',
>                          '_remote_printers': '1',
>                          '_share_printers': '0',
>                          '_user_cancel_any': '0'},
> 'error_log_checkpoint': 346977,
> 'error_log_debug_logging_set': True}
>Page 11 (Print test page):
>{'test_page_attempted': '16/Aug/2013:18:10:48 +0000',
> 'test_page_completions': [(16, u'Job completed.')],
> 'test_page_job_id': [16],
> 'test_page_job_status': [(True,
>                           16,
>                           'Brother-HL-2040-series',
>                           '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': 16,
>                            'job-k-octets': 1,
>                            'job-media-progress': 0,
>                            'job-media-sheets-completed': 1,
>                            'job-more-info': u'http://localhost:631/jobs/16',
>                            'job-preserved': False,
>                            'job-printer-state-message': u'',
>                            'job-printer-state-reasons': [u'none'],
>                            'job-printer-up-time': 1376691252,
>                            'job-printer-uri': u'ipp://localhost:631/printers/Brother-HL-2040-series',
>                            '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/16',
>                            'job-uuid': u'urn:uuid:bd7533d4-3235-37c3-49d8-8bcf8a51aed5',
>                            'printer-uri': u'ipp://localhost/printers/Brother-HL-2040-series',
>                            'time-at-completed': 1376691051,
>                            'time-at-creation': 1376691048,
>                            'time-at-processing': 1376691048}),
>                          (True,
>                           17,
>                           'Brother-HL-2040-series',
>                           'A9ROtiQ9xU',
>                           'Completed',
>                           {'EconoMode': u'off',
>                            'InputSlot': u'auto',
>                            'MediaType': u'plain',
>                            'PageRegion': u'Letter',
>                            'PageSize': u'Letter',
>                            'Resolution': u'300x300dpi',
>                            'attributes-charset': u'utf-8',
>                            'attributes-natural-language': u'en-us',
>                            'copies': 1,
>                            'document-count': 0,
>                            'document-format': u'application/postscript',
>                            'finishings': 3,
>                            'job-hold-until': u'no-hold',
>                            'job-id': 17,
>                            'job-k-octets': 601,
>                            'job-media-progress': 0,
>                            'job-media-sheets-completed': 1,
>                            'job-more-info': u'http://localhost:631/jobs/17',
>                            'job-preserved': False,
>                            'job-printer-state-message': u'',
>                            'job-printer-state-reasons': [u'none'],
>                            'job-printer-up-time': 1376691252,
>                            'job-printer-uri': u'ipp://localhost:631/printers/Brother-HL-2040-series',
>                            '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/17',
>                            'job-uuid': u'urn:uuid:0eb705d4-47be-3e2f-4852-630cd3018f66',
>                            'media': u'na_letter_8.5x11in',
>                            'number-up': 1,
>                            'output-bin': u'face-down',
>                            'print-color-mode': u'monochrome',
>                            'print-quality': 4,
>                            'printer-uri': u'ipp://localhost:631/printers/Brother-HL-2040-series',
>                            'time-at-completed': 1376691220,
>                            'time-at-creation': 1376691212,
>                            'time-at-processing': 1376691212})],
> 'test_page_successful': True}
>Page 12 (Error log fetch):
>{'error_log': ['D [16/Aug/2013:18:09:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdReadClient: 15 1.1 Get-Jobs 1',
>               'D [16/Aug/2013:18:09:51 -0400] Get-Jobs ipp://localhost/printers/',
>               'D [16/Aug/2013:18:09:51 -0400] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdReadClient: 15 1.1 Get-Jobs 1',
>               'D [16/Aug/2013:18:09:51 -0400] Get-Jobs ipp://localhost/printers/',
>               'D [16/Aug/2013:18:09:51 -0400] [Job 10] Loading attributes...',
>               'D [16/Aug/2013:18:09:51 -0400] [Job 11] Loading attributes...',
>               'D [16/Aug/2013:18:09:51 -0400] [Job 12] Loading attributes...',
>               'D [16/Aug/2013:18:09:51 -0400] [Job 13] Loading attributes...',
>               'D [16/Aug/2013:18:09:51 -0400] [Job 14] Loading attributes...',
>               'D [16/Aug/2013:18:09:51 -0400] [Job 15] Loading attributes...',
>               'D [16/Aug/2013:18:09:51 -0400] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdReadClient: 15 1.1 Create-Printer-Subscription 1',
>               'D [16/Aug/2013:18:09:51 -0400] Create-Printer-Subscription /',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdCreateSubscription(con=0x7f898f066820(15), uri="/")',
>               'D [16/Aug/2013:18:09:51 -0400] pullmethod="ippget"',
>               'D [16/Aug/2013:18:09:51 -0400] notify-lease-duration=86400',
>               'D [16/Aug/2013:18:09:51 -0400] notify-time-interval=0',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")',
>               'D [16/Aug/2013:18:09:51 -0400] Added subscription #49 for server.',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:09:51 -0400] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost',
>               'D [16/Aug/2013:18:09:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:09:53 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:09:53 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:09:53 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:09:53 -0400] cupsdReadClient: 15 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:09:53 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:09:53 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:09:53 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:09:53 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'I [16/Aug/2013:18:10:19 -0400] Generating printcap /etc/printcap...',
>               'I [16/Aug/2013:18:10:19 -0400] Saving subscriptions.conf...',
>               'D [16/Aug/2013:18:10:19 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"',
>               'D [16/Aug/2013:18:10:41 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:41 -0400] cupsdAcceptClient: 16 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:41 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:41 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:10:41 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:41 -0400] cupsdReadClient: 16 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:10:41 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:10:41 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:10:41 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:10:41 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:10:41 -0400] cupsdReadClient: 16 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:41 -0400] cupsdCloseClient: 16',
>               'D [16/Aug/2013:18:10:41 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdAcceptClient: 16 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdReadClient: 16 POST /printers/Brother-HL-2040-series HTTP/1.1',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdReadClient: 16 1.1 Print-Job 1',
>               'D [16/Aug/2013:18:10:48 -0400] Print-Job ipp://localhost/printers/Brother-HL-2040-series',
>               'D [16/Aug/2013:18:10:48 -0400] [Job ???] Auto-typing file...',
>               'I [16/Aug/2013:18:10:48 -0400] [Job ???] Request file type is application/vnd.cups-banner.',
>               'D [16/Aug/2013:18:10:48 -0400] add_job: setting context of job to UNKNOWN SL',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdMarkDirty(----J-)',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"',
>               'D [16/Aug/2013:18:10:48 -0400] add_job: requesting-user-name="root"',
>               'D [16/Aug/2013:18:10:48 -0400] Adding default job-sheets values "none,none"...',
>               'I [16/Aug/2013:18:10:48 -0400] [Job 16] Adding start banner page "none".',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdMarkDirty(----J-)',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'I [16/Aug/2013:18:10:48 -0400] [Job 16] Adding end banner page "none".',
>               'I [16/Aug/2013:18:10:48 -0400] [Job 16] File of type application/vnd.cups-banner queued by "root".',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] hold_until=0',
>               'I [16/Aug/2013:18:10:48 -0400] [Job 16] Queued on "Brother-HL-2040-series" by "root".',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdMarkDirty(----J-)',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] job-sheets=none,none',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] argv[0]="Brother-HL-2040-series"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] argv[1]="16"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] argv[2]="root"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] argv[3]="Test Page"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] argv[4]="1"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] argv[5]="job-uuid=urn:uuid:bd7533d4-3235-37c3-49d8-8bcf8a51aed5 job-originating-host-name=localhost time-at-creation=1376691048 time-at-processing=1376691048"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] argv[6]="/var/spool/cups/d00016-001"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[0]="CUPS_CACHEDIR=/var/cache/cups"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[1]="CUPS_DATADIR=/usr/share/cups"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[6]="CUPS_SERVERROOT=/etc/cups"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[7]="CUPS_STATEDIR=/var/run/cups"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[8]="HOME=/var/spool/cups/tmp"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[10]="SERVER_ADMIN=root@localhost.localdomain"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[11]="SOFTWARE=CUPS/1.5.4"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[12]="TMPDIR=/var/spool/cups/tmp"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[13]="USER=root"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[14]="CUPS_MAX_MESSAGE=2047"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[16]="CUPS_ENCRYPTION=IfRequested"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[17]="IPP_PORT=631"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[18]="CHARSET=utf-8"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[19]="LANG=en_US.UTF-8"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[20]="PPD=/etc/cups/ppd/Brother-HL-2040-series.ppd"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[21]="RIP_MAX_CACHE=128m"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[22]="CONTENT_TYPE=application/vnd.cups-banner"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[23]="DEVICE_URI=usb://Brother/HL-2040%20series?serial=C5J556102"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[24]="PRINTER_INFO=Brother HL-2040 series"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[25]="PRINTER_LOCATION=localhost.localdomain"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[26]="PRINTER=Brother-HL-2040-series"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[27]="PRINTER_STATE_REASONS=none"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[28]="CUPS_FILETYPE=document"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[29]="FINAL_CONTENT_TYPE=printer/Brother-HL-2040-series"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] envp[30]="AUTH_I****"',
>               'I [16/Aug/2013:18:10:48 -0400] [Job 16] Started filter /usr/lib/cups/filter/bannertops (PID 5213)',
>               'I [16/Aug/2013:18:10:48 -0400] [Job 16] Started filter /usr/lib/cups/filter/pstops (PID 5214)',
>               'I [16/Aug/2013:18:10:48 -0400] [Job 16] Started filter /usr/lib/cups/filter/foomatic-rip (PID 5215)',
>               'I [16/Aug/2013:18:10:48 -0400] [Job 16] Started backend /usr/lib/cups/backend/usb (PID 5216)',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:48 -0400] Returning IPP successful-ok for Print-Job (ipp://localhost/printers/Brother-HL-2040-series) from localhost',
>               'D [16/Aug/2013:18:10:48 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Getting input from file',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] foomatic-rip version 4.0.15.251 running...',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Parsing PPD file ...',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Added option ColorSpace',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Added option PageSize',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Added option ImageableArea',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Added option PaperDimension',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Added option EconoMode',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Added option InputSlot',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Added option Resolution',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] load_banner(filename="/var/spool/cups/d00016-001")',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] 1 #CUPS-BANNER',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] 2 Show printer-name printer-info printer-location printer-make-and-model printer-driver-name printer-driver-version paper-size imageable-area',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] 3 Header Printer Test Page',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] 4 Footer Printer Test Page',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] 5 Notice CUPS 1.5.4.',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] 6 Image images/cups.png',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] 7 Image images/color-wheel.png',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Added option MediaType',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Added option Font',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Printing on printer with URI: usb://Brother/HL-2040%20series?serial=C5J556102',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Parameter Summary',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] -----------------',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Spooler: cups',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Printer: Brother-HL-2040-series',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Shell: /bin/bash',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] PPD file: /etc/cups/ppd/Brother-HL-2040-series.ppd',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] ATTR file:',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Printer model: Brother HL-2040 Foomatic/hl1250 (recommended)',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Job title: Test Page',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] File(s) to be printed:',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] <STDIN>',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16]',
>               "D [16/Aug/2013:18:10:48 -0400] [Job 16] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts",
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Printing system options:',
>               "D [16/Aug/2013:18:10:48 -0400] [Job 16] Pondering option 'job-uuid=urn:uuid:bd7533d4-3235-37c3-49d8-8bcf8a51aed5'",
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Unknown option job-uuid=urn:uuid:bd7533d4-3235-37c3-49d8-8bcf8a51aed5.',
>               "D [16/Aug/2013:18:10:48 -0400] [Job 16] Pondering option 'job-originating-host-name=localhost'",
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Unknown option job-originating-host-name=localhost.',
>               "D [16/Aug/2013:18:10:48 -0400] [Job 16] Pondering option 'time-at-creation=1376691048'",
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Unknown option time-at-creation=1376691048.',
>               "D [16/Aug/2013:18:10:48 -0400] [Job 16] Pondering option 'time-at-processing=137669104'",
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Unknown option time-at-processing=137669104.',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Options from the PPD file:',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] ================================================',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] File: <STDIN>',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] ================================================',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Page = 612x792; 18,36 to 594,756',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] libusb_get_device_list=6',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Page = 612x792; 18,36 to 594,756',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] slow_collate=0, slow_duplex=0, slow_order=0',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Before copy_comments - %!PS-Adobe-3.0',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %!PS-Adobe-3.0',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%BoundingBox: 18 36 594 756',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %cupsRotation: 0',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%Creator: bannertops/CUPS v1.5.4',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%CreationDate: Fri 16 Aug 2013 06:10:48 PM EDT',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%LanguageLevel: 2',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%DocumentData: Clean7Bit',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%Title: (Test Page)',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%For: (root)',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%Pages: 1',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%DocumentSuppliedResources: font Monospace',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%+ font Monospace-Bold',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%+ font Monospace-BoldOblique',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%+ font Monospace-Oblique',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] %%EndComments',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Before copy_prolog - %%BeginProlog',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Filetype: PostScript',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Reading PostScript input ...',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] --> This document is DSC-conforming!',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Found %RBINumCopies: 1',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] -----------',
>               'D [16/Aug/2013:18:10:48 -0400] [Job 16] Found: %%BeginProlog',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] STATE: +connecting-to-device',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] Report: clients=2',
>               'D [16/Aug/2013:18:10:49 -0400] Report: jobs=7',
>               'D [16/Aug/2013:18:10:49 -0400] Report: jobs-active=1',
>               'D [16/Aug/2013:18:10:49 -0400] Report: printers=3',
>               'D [16/Aug/2013:18:10:49 -0400] Report: printers-implicit=0',
>               'D [16/Aug/2013:18:10:49 -0400] Report: stringpool-string-count=11146',
>               'D [16/Aug/2013:18:10:49 -0400] Report: stringpool-alloc-bytes=14672',
>               'D [16/Aug/2013:18:10:49 -0400] Report: stringpool-total-bytes=204176',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] STATE: -connecting-to-device',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Device protocol: 2',
>               'I [16/Aug/2013:18:10:49 -0400] [Job 16] Sending data to printer.',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Set job-printer-state-message to "Sending data to printer.", current level=INFO',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] PNG image: 128x128x8, color_type=6 (RGB+ALPHA)',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] PNG image: 192x128x8, color_type=2 (RGB)',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Before copy_setup - %%Page: coverpage 1',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Before page loop - %%Page: coverpage 1',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Copying page 1...',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] pagew = 576.0, pagel = 720.0',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] PageLeft = 18.0, PageRight = 594.0',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] PageTop = 756.0, PageBottom = 36.0',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] PageWidth = 612.0, PageLength = 792.0',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %%EndProlog',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] -----------',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %%BeginSetup',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %%BeginFeature: *EconoMode off',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Option: EconoMode=off',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Setting option',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %% FoomaticRIPOptionSetting: EconoMode=off',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Option: EconoMode=off',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Setting option',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %%BeginFeature: *PageSize Letter',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Option: PageSize=Letter',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Setting option',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %% FoomaticRIPOptionSetting: PageSize=Letter',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Option: PageSize=Letter',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Setting option',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %%BeginFeature: *InputSlot auto',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Option: InputSlot=auto',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Setting option',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %% FoomaticRIPOptionSetting: InputSlot=auto',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Option: InputSlot=auto',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Setting option',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %%BeginFeature: *Resolution 300x300dpi',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Option: Resolution=300x300dpi',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Setting option',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %% FoomaticRIPOptionSetting: Resolution=300x300dpi',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Option: Resolution=300x300dpi',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Setting option',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %%BeginFeature: *MediaType plain',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Option: MediaType=plain',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Setting option',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %% FoomaticRIPOptionSetting: MediaType=plain',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Option: MediaType=plain',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Setting option',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %%EndSetup',
>               "D [16/Aug/2013:18:10:49 -0400] [Job 16] Inserting PostScript code for CUPS' page accounting",
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] -----------',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] New page: %%Page: coverpage 1',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Found: %%BeginPageSetup',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Inserting option code into "PageSetup" section.',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Wrote 1 pages...',
>               'D [16/Aug/2013:18:10:49 -0400] PID 5214 (/usr/lib/cups/filter/pstops) exited with no errors.',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Flushing FIFO.',
>               'D [16/Aug/2013:18:10:49 -0400] PID 5213 (/usr/lib/cups/filter/bannertops) exited with no errors.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: 19 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: 20 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 19 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 20 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 19 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:10:49 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 20 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:10:49 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdIsAuthorized: requesting-user-name="jones"',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 20 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 20 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:10:49 -0400] Get-Job-Attributes ipp://localhost/jobs/16',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/16) from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: 21 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 21 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 21 1.1 Get-Printer-Attributes 1',
>               'D [16/Aug/2013:18:10:49 -0400] Get-Printer-Attributes',
>               'D [16/Aug/2013:18:10:49 -0400] Get-Printer-Attributes client-error-not-found: The printer or class does not exist.',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP client-error-not-found for Get-Printer-Attributes () from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: 22 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 22 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 22 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:10:49 -0400] Get-Job-Attributes ipp://localhost/jobs/16',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/16) from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 22 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdCloseClient: 22',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 21 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdCloseClient: 21',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: 21 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 21 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 21 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:10:49 -0400] Get-Job-Attributes ipp://localhost/jobs/16',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/16) from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: 22 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdCloseClient: 16',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 21 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdCloseClient: 21',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: 16 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:10:49 -0400] Get-Job-Attributes ipp://localhost/jobs/16',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/16) from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdCloseClient: 16',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 19 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdCloseClient: 19',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 15 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:10:49 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: 16 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:10:49 -0400] Get-Job-Attributes ipp://localhost/jobs/16',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/16) from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdCloseClient: 16',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 20 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdCloseClient: 20',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAcceptClient: 16 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1',
>               'D [16/Aug/2013:18:10:49 -0400] CUPS-Get-Printers',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Classes 1',
>               'D [16/Aug/2013:18:10:49 -0400] CUPS-Get-Classes',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Default 1',
>               'D [16/Aug/2013:18:10:49 -0400] CUPS-Get-Default',
>               'D [16/Aug/2013:18:10:49 -0400] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
>               'D [16/Aug/2013:18:10:49 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Starting renderer with command: "gs -sstdout=%stderr  -dBATCH -dPARANOIDSAFER -dNOPAUSE -dNOINTERPOLATE -sDEVICE=hl1250 -dEconoMode=0 -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -r300x300 -dSourceTray=0 -dPaperType=0 -sOutputFile=%stdout -f -_"',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Starting process "kid3" (generation 1)',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Starting process "kid4" (generation 2)',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Starting process "renderer" (generation 2)',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] JCL: \x1b%-12345X@PJL',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] <job data>',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] GPL Ghostscript 9.06 (2012-08-08)',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] Copyright (C) 2012 Artifex Software, Inc.  All rights reserved.',
>               'D [16/Aug/2013:18:10:49 -0400] [Job 16] This software comes with NO WARRANTY: see the file PUBLIC for details.',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] Closing renderer',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] PAGE: 1 1',
>               'D [16/Aug/2013:18:10:50 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:10:50 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] renderer exited with status 0',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] kid4 exited with status 0',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] kid3 finished',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] kid3 exited with status 0',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16]',
>               'D [16/Aug/2013:18:10:50 -0400] [Job 16] Closing foomatic-rip.',
>               'D [16/Aug/2013:18:10:50 -0400] PID 5215 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.',
>               'D [16/Aug/2013:18:10:51 -0400] [Job 16] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:10:51 -0400] [Job 16] Read 6405 bytes of print data...',
>               'D [16/Aug/2013:18:10:51 -0400] [Job 16] Wrote 6405 bytes of print data...',
>               'D [16/Aug/2013:18:10:51 -0400] [Job 16] Sent 47365 bytes...',
>               'D [16/Aug/2013:18:10:51 -0400] [Job 16] Waiting for read thread to exit...',
>               'D [16/Aug/2013:18:10:51 -0400] PID 5216 (/usr/lib/cups/backend/usb) exited with no errors.',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'I [16/Aug/2013:18:10:51 -0400] [Job 16] Job completed.',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdMarkDirty(----J-)',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAcceptClient: 18 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 18 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 18 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:10:51 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:10:51 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAcceptClient: 19 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 18 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdCloseClient: 18',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 19 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 19 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:10:51 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdIsAuthorized: requesting-user-name="jones"',
>               'D [16/Aug/2013:18:10:51 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 15 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:10:51 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:10:51 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAcceptClient: 18 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 18 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 18 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:10:51 -0400] Get-Job-Attributes ipp://localhost/jobs/16',
>               'D [16/Aug/2013:18:10:51 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/16) from localhost',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 18 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdCloseClient: 18',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAcceptClient: 18 from localhost (Domain)',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 18 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 18 1.1 Get-Printer-Attributes 1',
>               'D [16/Aug/2013:18:10:51 -0400] Get-Printer-Attributes ipp://localhost.localdomain/printers/Brother-HL-2040-series',
>               'D [16/Aug/2013:18:10:51 -0400] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost.localdomain/printers/Brother-HL-2040-series) from localhost',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 19 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdCloseClient: 19',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1',
>               'D [16/Aug/2013:18:10:51 -0400] CUPS-Get-Printers',
>               'D [16/Aug/2013:18:10:51 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Classes 1',
>               'D [16/Aug/2013:18:10:51 -0400] CUPS-Get-Classes',
>               'D [16/Aug/2013:18:10:51 -0400] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Default 1',
>               'D [16/Aug/2013:18:10:51 -0400] CUPS-Get-Default',
>               'D [16/Aug/2013:18:10:51 -0400] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
>               'D [16/Aug/2013:18:10:51 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:10:52 -0400] [Job 10] Unloading...',
>               'D [16/Aug/2013:18:10:52 -0400] [Job 11] Unloading...',
>               'D [16/Aug/2013:18:10:52 -0400] [Job 12] Unloading...',
>               'D [16/Aug/2013:18:10:52 -0400] [Job 13] Unloading...',
>               'D [16/Aug/2013:18:10:52 -0400] [Job 14] Unloading...',
>               'D [16/Aug/2013:18:10:52 -0400] [Job 15] Unloading...',
>               'I [16/Aug/2013:18:11:19 -0400] Saving job.cache...',
>               'I [16/Aug/2013:18:11:20 -0400] Saving subscriptions.conf...',
>               'D [16/Aug/2013:18:11:20 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"',
>               'D [16/Aug/2013:18:11:52 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:11:52 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:11:52 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:11:52 -0400] [Job 16] Unloading...',
>               'D [16/Aug/2013:18:11:52 -0400] Report: clients=4',
>               'D [16/Aug/2013:18:11:52 -0400] Report: jobs=7',
>               'D [16/Aug/2013:18:11:52 -0400] Report: jobs-active=0',
>               'D [16/Aug/2013:18:11:52 -0400] Report: printers=3',
>               'D [16/Aug/2013:18:11:52 -0400] Report: printers-implicit=0',
>               'D [16/Aug/2013:18:11:52 -0400] Report: stringpool-string-count=11013',
>               'D [16/Aug/2013:18:11:52 -0400] Report: stringpool-alloc-bytes=13448',
>               'D [16/Aug/2013:18:11:52 -0400] Report: stringpool-total-bytes=201520',
>               'D [16/Aug/2013:18:11:52 -0400] cupsdReadClient: 15 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:11:52 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:11:52 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:11:52 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:11:52 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:12:52 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:12:52 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:12:52 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:12:52 -0400] Report: clients=4',
>               'D [16/Aug/2013:18:12:52 -0400] Report: jobs=7',
>               'D [16/Aug/2013:18:12:52 -0400] Report: jobs-active=0',
>               'D [16/Aug/2013:18:12:52 -0400] Report: printers=3',
>               'D [16/Aug/2013:18:12:52 -0400] Report: printers-implicit=0',
>               'D [16/Aug/2013:18:12:52 -0400] Report: stringpool-string-count=11013',
>               'D [16/Aug/2013:18:12:52 -0400] Report: stringpool-alloc-bytes=13448',
>               'D [16/Aug/2013:18:12:52 -0400] Report: stringpool-total-bytes=201520',
>               'D [16/Aug/2013:18:12:52 -0400] cupsdReadClient: 15 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:12:52 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:12:52 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:12:52 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:12:52 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAcceptClient: 19 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1',
>               'D [16/Aug/2013:18:13:05 -0400] CUPS-Get-Printers',
>               'D [16/Aug/2013:18:13:05 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 1.1 CUPS-Get-Default 1',
>               'D [16/Aug/2013:18:13:05 -0400] CUPS-Get-Default',
>               'D [16/Aug/2013:18:13:05 -0400] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1',
>               'D [16/Aug/2013:18:13:05 -0400] CUPS-Get-Printers',
>               'D [16/Aug/2013:18:13:05 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 1.1 CUPS-Get-Default 1',
>               'D [16/Aug/2013:18:13:05 -0400] CUPS-Get-Default',
>               'D [16/Aug/2013:18:13:05 -0400] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1',
>               'D [16/Aug/2013:18:13:05 -0400] CUPS-Get-Printers',
>               'D [16/Aug/2013:18:13:05 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 19 1.1 CUPS-Get-Default 1',
>               'D [16/Aug/2013:18:13:05 -0400] CUPS-Get-Default',
>               'D [16/Aug/2013:18:13:05 -0400] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAcceptClient: 20 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 20 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 20 1.1 CUPS-Get-Printers 1',
>               'D [16/Aug/2013:18:13:05 -0400] CUPS-Get-Printers',
>               'D [16/Aug/2013:18:13:05 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 20 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 20 1.1 CUPS-Get-Default 1',
>               'D [16/Aug/2013:18:13:05 -0400] CUPS-Get-Default',
>               'D [16/Aug/2013:18:13:05 -0400] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 20 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 20 1.1 Get-Printer-Attributes 1',
>               'D [16/Aug/2013:18:13:05 -0400] Get-Printer-Attributes ipp://localhost/printers/Brother-HL-2040-series',
>               'D [16/Aug/2013:18:13:05 -0400] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother-HL-2040-series) from localhost',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 20 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 20 1.1 Get-Jobs 1',
>               'D [16/Aug/2013:18:13:05 -0400] Get-Jobs ipp://localhost/printers/Brother-HL-2040-series',
>               'D [16/Aug/2013:18:13:05 -0400] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/Brother-HL-2040-series) from localhost',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdReadClient: 20 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdCloseClient: 20',
>               'D [16/Aug/2013:18:13:05 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"',
>               'D [16/Aug/2013:18:13:29 -0400] cupsdReadClient: 19 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:29 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:29 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:29 -0400] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1',
>               'D [16/Aug/2013:18:13:29 -0400] CUPS-Get-Printers',
>               'D [16/Aug/2013:18:13:29 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
>               'D [16/Aug/2013:18:13:29 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:29 -0400] cupsdReadClient: 19 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:29 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:29 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:29 -0400] cupsdReadClient: 19 1.1 CUPS-Get-Default 1',
>               'D [16/Aug/2013:18:13:29 -0400] CUPS-Get-Default',
>               'D [16/Aug/2013:18:13:29 -0400] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
>               'D [16/Aug/2013:18:13:29 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: 20 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 1.1 Get-Printer-Attributes 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Printer-Attributes ipp://localhost:631/printers/Brother-HL-2040-series',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/Brother-HL-2040-series) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 POST /printers/Brother-HL-2040-series HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 1.1 Create-Job 1',
>               'D [16/Aug/2013:18:13:32 -0400] Create-Job ipp://localhost:631/printers/Brother-HL-2040-series',
>               'D [16/Aug/2013:18:13:32 -0400] add_job: setting context of job to UNKNOWN SL',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdMarkDirty(----J-)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"',
>               'D [16/Aug/2013:18:13:32 -0400] add_job: requesting-user-name="jones"',
>               'I [16/Aug/2013:18:13:32 -0400] [Job 17] Adding start banner page "none".',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'I [16/Aug/2013:18:13:32 -0400] [Job 17] Queued on "Brother-HL-2040-series" by "jones".',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/Brother-HL-2040-series) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 POST /printers/Brother-HL-2040-series HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 1.1 Send-Document 1',
>               'D [16/Aug/2013:18:13:32 -0400] Send-Document ipp://localhost:631/printers/Brother-HL-2040-series',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdIsAuthorized: requesting-user-name="jones"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Auto-typing file...',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Request file type is application/postscript.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdMarkDirty(----J-)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'I [16/Aug/2013:18:13:32 -0400] [Job 17] File of type application/postscript queued by "jones".',
>               'I [16/Aug/2013:18:13:32 -0400] [Job 17] Adding end banner page "none".',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdMarkDirty(----J-)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdMarkDirty(----J-)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] job-sheets=none,none',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] argv[0]="Brother-HL-2040-series"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] argv[1]="17"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] argv[2]="jones"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] argv[3]="A9ROtiQ9xU"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] argv[4]="1"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] argv[5]="EconoMode=off finishings=3 InputSlot=auto media=na_letter_8.5x11in MediaType=plain number-up=1 output-bin=face-down PageRegion=Letter PageSize=Letter print-color-mode=monochrome print-quality=4 Resolution=300x300dpi job-uuid=urn:uuid:0eb705d4-47be-3e2f-4852-630cd3018f66 job-originating-host-name=localhost time-at-creation=1376691212 time-at-processing=1376691212"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] argv[6]="/var/spool/cups/d00017-001"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[0]="CUPS_CACHEDIR=/var/cache/cups"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[1]="CUPS_DATADIR=/usr/share/cups"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[6]="CUPS_SERVERROOT=/etc/cups"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[7]="CUPS_STATEDIR=/var/run/cups"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[8]="HOME=/var/spool/cups/tmp"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[10]="SERVER_ADMIN=root@localhost.localdomain"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[11]="SOFTWARE=CUPS/1.5.4"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[12]="TMPDIR=/var/spool/cups/tmp"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[13]="USER=root"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[14]="CUPS_MAX_MESSAGE=2047"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[16]="CUPS_ENCRYPTION=IfRequested"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[17]="IPP_PORT=631"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[18]="CHARSET=utf-8"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[19]="LANG=en_US.UTF-8"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[20]="PPD=/etc/cups/ppd/Brother-HL-2040-series.ppd"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[21]="RIP_MAX_CACHE=128m"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[22]="CONTENT_TYPE=application/postscript"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[23]="DEVICE_URI=usb://Brother/HL-2040%20series?serial=C5J556102"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[24]="PRINTER_INFO=Brother HL-2040 series"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[25]="PRINTER_LOCATION=localhost.localdomain"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[26]="PRINTER=Brother-HL-2040-series"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[27]="PRINTER_STATE_REASONS=none"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[28]="CUPS_FILETYPE=document"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[29]="FINAL_CONTENT_TYPE=printer/Brother-HL-2040-series"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] envp[30]="AUTH_I****"',
>               'I [16/Aug/2013:18:13:32 -0400] [Job 17] Started filter /usr/lib/cups/filter/pstops (PID 5304)',
>               'I [16/Aug/2013:18:13:32 -0400] [Job 17] Started filter /usr/lib/cups/filter/foomatic-rip (PID 5305)',
>               'I [16/Aug/2013:18:13:32 -0400] [Job 17] Started backend /usr/lib/cups/backend/usb (PID 5306)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/Brother-HL-2040-series) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdCloseClient: 20',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Getting input from file',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] foomatic-rip version 4.0.15.251 running...',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Parsing PPD file ...',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Added option ColorSpace',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Added option PageSize',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Added option ImageableArea',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Added option PaperDimension',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Added option EconoMode',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Added option InputSlot',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Added option Resolution',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Added option MediaType',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Added option Font',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Parameter Summary',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] -----------------',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Spooler: cups',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Printer: Brother-HL-2040-series',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Shell: /bin/bash',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] PPD file: /etc/cups/ppd/Brother-HL-2040-series.ppd',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] ATTR file:',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Printer model: Brother HL-2040 Foomatic/hl1250 (recommended)',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Job title: A9ROtiQ9xU',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] File(s) to be printed:',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] <STDIN>',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Printing system options:',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'finishings=3'",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Unknown option finishings=3.',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'media=na_letter_8.5x11in'",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Unknown "media" component: "na_letter_8.5x11in".',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'number-up=1'",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Unknown option number-up=1.',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'output-bin=face-down'",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Unknown option output-bin=face-down.',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'print-color-mode=monochrome'",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Unknown option print-color-mode=monochrome.',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'print-quality=4'",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Unknown option print-quality=4.',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'job-uuid=urn:uuid:0eb705d4-47be-3e2f-4852-630cd3018f66'",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Unknown option job-uuid=urn:uuid:0eb705d4-47be-3e2f-4852-630cd3018f66.',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'job-originating-host-name=localhost'",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Unknown option job-originating-host-name=localhost.',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'time-at-creation=1376691212'",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Unknown option time-at-creation=1376691212.',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'time-at-processing=137669121'",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Unknown option time-at-processing=137669121.',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Options from the PPD file:',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'EconoMode=off'",
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'InputSlot=auto'",
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'MediaType=plain'",
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'PageRegion=Letter'",
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'PageSize=Letter'",
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Pondering option 'Resolution=300x300dpi'",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] ================================================',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] File: <STDIN>',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] ================================================',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Page = 612x792; 18,36 to 594,756',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] slow_collate=0, slow_duplex=0, slow_order=0',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Before copy_comments - %!PS-Adobe-3.1',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %!PS-Adobe-3.1',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %ADO_DSC_Encoding: MacOS Roman',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%Title: Eticket_20130816.pdf',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%Creator: Adobe Acrobat 9.5.3',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%For: jones',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%CreationDate: 08/16/2013, 06:13:30 PM',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%BoundingBox: 51 36 561 756',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%HiResBoundingBox: 51.6057 36 560.3943 756',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%CropBox: 51.6057 36 560.3943 756',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%LanguageLevel: 3',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%DocumentNeededResources: (atend)',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%DocumentSuppliedResources: (atend)',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%DocumentNeededFeatures: (atend)',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%DocumentSuppliedFeatures: (atend)',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%DocumentData: Clean7Bit',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%PageOrder: Ascend',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%TargetDevice: (HL-2040) (3010.000) 550',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%Pages: (atend)',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%DocumentProcessColors: (atend)',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%DocumentCustomColors: (atend)',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] %%EndComments',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Printing on printer with URI: usb://Brother/HL-2040%20series?serial=C5J556102',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Before copy_prolog - %%BeginDefaults',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Filetype: PostScript',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Reading PostScript input ...',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] --> This document is DSC-conforming!',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found %RBINumCopies: 1',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Job claims to be DSC-conforming, but "%%BeginProlog" was missing before first line with another"%%BeginProlog" comment (is this a TeX/LaTeX/dvips-generated PostScript file?). Assuming start of "Prolog" here.',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] -----------',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%BeginProlog',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: 20 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: 23 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 23 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 23 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdIsAuthorized: requesting-user-name="jones"',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdCloseClient: 20',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 15 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 23 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 23 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Job-Attributes ipp://localhost/jobs/17',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] libusb_get_device_list=6',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: 20 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 1.1 Get-Printer-Attributes 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Printer-Attributes',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Printer-Attributes client-error-not-found: The printer or class does not exist.',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP client-error-not-found for Get-Printer-Attributes () from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Before copy_setup - %%BeginSetup',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: 24 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Job-Attributes ipp://localhost/jobs/17',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdCloseClient: 24',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Before page loop - %%Page: 1 1',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Copying page 1...',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] pagew = 576.0, pagel = 720.0',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] PageLeft = 18.0, PageRight = 594.0',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] PageTop = 756.0, PageBottom = 36.0',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] PageWidth = 612.0, PageLength = 792.0',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%EndProlog',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] -----------',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%BeginSetup',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%BeginFeature: *EconoMode off',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: EconoMode=off',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %% FoomaticRIPOptionSetting: EconoMode=off',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: EconoMode=off',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%BeginFeature: *PageSize Letter',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: PageSize=Letter',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %% FoomaticRIPOptionSetting: PageSize=Letter',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: PageSize=Letter',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%BeginFeature: *InputSlot auto',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: InputSlot=auto',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %% FoomaticRIPOptionSetting: InputSlot=auto',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: InputSlot=auto',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%BeginFeature: *Resolution 300x300dpi',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: Resolution=300x300dpi',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %% FoomaticRIPOptionSetting: Resolution=300x300dpi',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: 24 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdCloseClient: 20',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] STATE: +connecting-to-device',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] STATE: -connecting-to-device',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Job-Attributes ipp://localhost/jobs/17',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: Resolution=300x300dpi',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%BeginFeature: *MediaType plain',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: MediaType=plain',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %% FoomaticRIPOptionSetting: MediaType=plain',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: MediaType=plain',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%BeginFeature: *PageSize Letter',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: PageSize=Letter',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %% FoomaticRIPOptionSetting: PageSize=Letter',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Option: PageSize=Letter',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Setting option',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Device protocol: 2',
>               'I [16/Aug/2013:18:13:32 -0400] [Job 17] Sending data to printer.',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Set job-printer-state-message to "Sending data to printer.", current level=INFO',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: 20 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%EndSetup',
>               "D [16/Aug/2013:18:13:32 -0400] [Job 17] Inserting PostScript code for CUPS' page accounting",
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] -----------',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] New page: %%Page: 1 1',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%BeginPageSetup',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Inserting option code into "PageSetup" section.',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Found: %%BeginPageSetup',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Inserting option code into "PageSetup" section.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 1.1 Get-Printer-Attributes 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Printer-Attributes ipp://localhost.localdomain/printers/Brother-HL-2040-series',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost.localdomain/printers/Brother-HL-2040-series) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 20 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Job-Attributes ipp://localhost/jobs/17',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdCloseClient: 24',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: 24 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Job-Attributes ipp://localhost/jobs/17',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdCloseClient: 24',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 23 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdCloseClient: 23',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1',
>               'D [16/Aug/2013:18:13:32 -0400] CUPS-Get-Printers',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Classes 1',
>               'D [16/Aug/2013:18:13:32 -0400] CUPS-Get-Classes',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Default 1',
>               'D [16/Aug/2013:18:13:32 -0400] CUPS-Get-Default',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Wrote 1 pages...',
>               'D [16/Aug/2013:18:13:32 -0400] PID 5304 (/usr/lib/cups/filter/pstops) exited with no errors.',
>               'D [16/Aug/2013:18:13:32 -0400] [Job 17] Flushing FIFO.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: 23 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 23 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 23 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 23 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdCloseClient: 23',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 15 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: 23 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 23 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 23 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdIsAuthorized: requesting-user-name="jones"',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAcceptClient: 24 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:13:32 -0400] Get-Job-Attributes ipp://localhost/jobs/17',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 24 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdCloseClient: 24',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 23 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdCloseClient: 23',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1',
>               'D [16/Aug/2013:18:13:32 -0400] CUPS-Get-Printers',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Classes 1',
>               'D [16/Aug/2013:18:13:32 -0400] CUPS-Get-Classes',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Default 1',
>               'D [16/Aug/2013:18:13:32 -0400] CUPS-Get-Default',
>               'D [16/Aug/2013:18:13:32 -0400] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
>               'D [16/Aug/2013:18:13:32 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"',
>               'D [16/Aug/2013:18:13:33 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:33 -0400] [Job 17] Starting renderer with command: "gs -sstdout=%stderr  -dBATCH -dPARANOIDSAFER -dNOPAUSE -dNOINTERPOLATE -sDEVICE=hl1250 -dEconoMode=0 -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -r300x300 -dSourceTray=0 -dPaperType=0 -sOutputFile=%stdout -f -_"',
>               'D [16/Aug/2013:18:13:33 -0400] [Job 17] Starting process "kid3" (generation 1)',
>               'D [16/Aug/2013:18:13:33 -0400] [Job 17] Starting process "kid4" (generation 2)',
>               'D [16/Aug/2013:18:13:33 -0400] [Job 17] Starting process "renderer" (generation 2)',
>               'D [16/Aug/2013:18:13:33 -0400] [Job 17] JCL: \x1b%-12345X@PJL',
>               'D [16/Aug/2013:18:13:33 -0400] [Job 17] <job data>',
>               'D [16/Aug/2013:18:13:33 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:33 -0400] [Job 17] GPL Ghostscript 9.06 (2012-08-08)',
>               'D [16/Aug/2013:18:13:33 -0400] [Job 17] Copyright (C) 2012 Artifex Software, Inc.  All rights reserved.',
>               'D [16/Aug/2013:18:13:33 -0400] [Job 17] This software comes with NO WARRANTY: see the file PUBLIC for details.',
>               'D [16/Aug/2013:18:13:37 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:37 -0400] [Job 17] Closing renderer',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] PAGE: 1 1',
>               'D [16/Aug/2013:18:13:38 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:13:38 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] renderer exited with status 0',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:38 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] kid4 exited with status 0',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] kid3 finished',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] kid3 exited with status 0',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17]',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Closing foomatic-rip.',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] PID 5305 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Read 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 8192 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Read 658 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Wrote 658 bytes of print data...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Sent 148114 bytes...',
>               'D [16/Aug/2013:18:13:39 -0400] [Job 17] Waiting for read thread to exit...',
>               'D [16/Aug/2013:18:13:40 -0400] PID 5306 (/usr/lib/cups/backend/usb) exited with no errors.',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'I [16/Aug/2013:18:13:40 -0400] [Job 17] Job completed.',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdMarkDirty(----J-)',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAcceptClient: 21 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAcceptClient: 23 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 21 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 23 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 21 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:13:40 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:13:40 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 23 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:13:40 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdIsAuthorized: requesting-user-name="jones"',
>               'D [16/Aug/2013:18:13:40 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 21 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdCloseClient: 21',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAcceptClient: 21 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 21 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 15 1.1 Get-Notifications 1',
>               'D [16/Aug/2013:18:13:40 -0400] Get-Notifications /',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:13:40 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 21 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:13:40 -0400] Get-Job-Attributes ipp://localhost/jobs/17',
>               'D [16/Aug/2013:18:13:40 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAcceptClient: 24 from localhost (Domain)',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 21 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdCloseClient: 21',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 18 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdCloseClient: 18',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 24 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 24 1.1 Get-Printer-Attributes 1',
>               'D [16/Aug/2013:18:13:40 -0400] Get-Printer-Attributes ipp://localhost.localdomain/printers/Brother-HL-2040-series',
>               'D [16/Aug/2013:18:13:40 -0400] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost.localdomain/printers/Brother-HL-2040-series) from localhost',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 23 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdCloseClient: 23',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1',
>               'D [16/Aug/2013:18:13:40 -0400] CUPS-Get-Printers',
>               'D [16/Aug/2013:18:13:40 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Classes 1',
>               'D [16/Aug/2013:18:13:40 -0400] CUPS-Get-Classes',
>               'D [16/Aug/2013:18:13:40 -0400] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 16 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdReadClient: 16 1.1 CUPS-Get-Default 1',
>               'D [16/Aug/2013:18:13:40 -0400] CUPS-Get-Default',
>               'D [16/Aug/2013:18:13:40 -0400] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost',
>               'D [16/Aug/2013:18:13:40 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'I [16/Aug/2013:18:14:03 -0400] Saving job.cache...',
>               'I [16/Aug/2013:18:14:03 -0400] Saving subscriptions.conf...',
>               'D [16/Aug/2013:18:14:04 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"',
>               'D [16/Aug/2013:18:14:04 -0400] Report: clients=6',
>               'D [16/Aug/2013:18:14:04 -0400] Report: jobs=8',
>               'D [16/Aug/2013:18:14:04 -0400] Report: jobs-active=0',
>               'D [16/Aug/2013:18:14:04 -0400] Report: printers=3',
>               'D [16/Aug/2013:18:14:04 -0400] Report: printers-implicit=0',
>               'D [16/Aug/2013:18:14:04 -0400] Report: stringpool-string-count=11313',
>               'D [16/Aug/2013:18:14:04 -0400] Report: stringpool-alloc-bytes=14080',
>               'D [16/Aug/2013:18:14:04 -0400] Report: stringpool-total-bytes=207768',
>               'D [16/Aug/2013:18:14:07 -0400] cupsdReadClient: 19 WAITING Closing on EOF',
>               'D [16/Aug/2013:18:14:07 -0400] cupsdCloseClient: 19',
>               'D [16/Aug/2013:18:14:07 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdReadClient: 15 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:14:12 -0400] Get-Job-Attributes ipp://localhost/jobs/16',
>               'D [16/Aug/2013:18:14:12 -0400] [Job 16] Loading attributes...',
>               'D [16/Aug/2013:18:14:12 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/16) from localhost',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdReadClient: 15 1.1 Get-Job-Attributes 1',
>               'D [16/Aug/2013:18:14:12 -0400] Get-Job-Attributes ipp://localhost/jobs/17',
>               'D [16/Aug/2013:18:14:12 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdReadClient: 15 POST / HTTP/1.1',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdReadClient: 15 1.1 Cancel-Subscription 1',
>               'D [16/Aug/2013:18:14:12 -0400] Cancel-Subscription /',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdIsAuthorized: requesting-user-name="root"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdMarkDirty(-----S)',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"',
>               'D [16/Aug/2013:18:14:12 -0400] Returning IPP successful-ok for Cancel-Subscription (/) from localhost',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdReadClient: 15 PUT /admin/conf/cupsd.conf HTTP/1.1',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdAuthorize: No authentication data provided.',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdIsAuthorized: username=""',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdSendHeader: 15 WWW-Authenticate: Basic realm="CUPS", trc="y"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdCloseClient: 15',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdAcceptClient: skipping getpeercon()',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdAcceptClient: 15 from localhost (Domain)',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdReadClient: 15 PUT /admin/conf/cupsd.conf HTTP/1.1',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdAuthorize: Authorized as root using PeerCred',
>               'D [16/Aug/2013:18:14:12 -0400] cupsdIsAuthorized: username="root"',
>               'I [16/Aug/2013:18:14:12 -0400] Installing config file "/etc/cups/cupsd.conf"...',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdCloseClient: 22',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdCloseClient: 16',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdCloseClient: 20',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdCloseClient: 24',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdCloseClient: 15',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdDeregisterPrinter(p=0x7f898f075750(Brother-HL-2040-series), removeit=1)',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdDeregisterPrinter(p=0x7f898f0e7b90(Deskjet_3512_wireless), removeit=1)',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdDeregisterPrinter(p=0x7f898f08d370(HP-Deskjet-3510-series-USB), removeit=1)',
>               'I [16/Aug/2013:18:14:13 -0400] Saving subscriptions.conf...',
>               'D [16/Aug/2013:18:14:13 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"',
>               'E [16/Aug/2013:18:14:13 -0400] Unknown directive JobPrivateAccess on line 86 of /etc/cups/cupsd.conf.',
>               'E [16/Aug/2013:18:14:13 -0400] Unknown directive JobPrivateValues on line 87 of /etc/cups/cupsd.conf.',
>               'E [16/Aug/2013:18:14:13 -0400] Unknown directive SubscriptionPrivateAccess on line 88 of /etc/cups/cupsd.conf.',
>               'E [16/Aug/2013:18:14:13 -0400] Unknown directive SubscriptionPrivateValues on line 89 of /etc/cups/cupsd.conf.',
>               "W [16/Aug/2013:18:14:13 -0400] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'Brother-HL-2040-series-Gray..' already exists",
>               "W [16/Aug/2013:18:14:13 -0400] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'Deskjet_3512_wireless-Gray..' already exists",
>               "W [16/Aug/2013:18:14:13 -0400] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'Deskjet_3512_wireless-RGB..' already exists",
>               "W [16/Aug/2013:18:14:13 -0400] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'HP-Deskjet-3510-series-USB-Gray..' already exists",
>               "W [16/Aug/2013:18:14:13 -0400] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'HP-Deskjet-3510-series-USB-RGB..' already exists"],
> 'error_log_debug_logging_unset': True}
>Page 13 (Locale issues):
>{'job_page_size': u'Letter',
> 'printer_page_size': u'Letter',
> 'system_locale_lang': 'en_US',
> 'user_locale_ctype': 'en_US',
> 'user_locale_messages': 'en_US'}

Actions: View

Attachments on bug 998056: 787463 | 787464 | 795759 | 804387 | 810508