Login
[x]
Log in using an account from:
Fedora Account System
Red Hat Associate
Red Hat Customer
Or login using a Red Hat Bugzilla account
Forgot Password
Login:
Hide Forgot
Create an Account
Red Hat Bugzilla – Attachment 614299 Details for
Bug 857388
HP deskjet 6940 garbled print
[?]
New
Simple Search
Advanced Search
My Links
Browse
Requests
Reports
Current State
Search
Tabular reports
Graphical reports
Duplicates
Other Reports
User Changes
Plotly Reports
Bug Status
Bug Severity
Non-Defaults
|
Product Dashboard
Help
Page Help!
Bug Writing Guidelines
What's new
Browser Support Policy
5.0.4.rh83 Release notes
FAQ
Guides index
User guide
Web Services
Contact
Legal
This site requires JavaScript to be enabled to function correctly, please enable it.
New troubleshoot.txt from 'test' hplip
troubleshoot.txt (text/plain), 171.91 KB, created by
Bob Goodwin
on 2012-09-19 10:09:06 UTC
(
hide
)
Description:
New troubleshoot.txt from 'test' hplip
Filename:
MIME Type:
Creator:
Bob Goodwin
Created:
2012-09-19 10:09:06 UTC
Size:
171.91 KB
patch
obsolete
>Page 1 (Scheduler not running?): >{'cups_connection_failure': False} >Page 2 (Choose printer): >{'cups_dest': <cups.Dest Deskjet_6940>, > 'cups_instance': None, > 'cups_queue': 'Deskjet_6940', > 'cups_queue_listed': True} >Page 3 (Check printer sanity): >{'cups_device_uri_scheme': u'hp', > 'cups_printer_dict': {'device-uri': u'hp:/net/Deskjet_6940_series?ip=169.254.78.213', > 'printer-info': u'Deskjet_6940', > 'printer-is-shared': True, > 'printer-location': u'', > 'printer-make-and-model': u'HP Deskjet 6940 Series, hpcups 3.12.9', > 'printer-state': 3, > 'printer-state-message': u'', > 'printer-state-reasons': [u'none'], > 'printer-type': 36892, > 'printer-uri-supported': u'ipp://localhost:631/printers/Deskjet_6940'}, > 'cups_printer_remote': False, > 'hplip_output': (['', > '\x1b[01mHP Linux Imaging and Printing System (ver. 3.12.9)\x1b[0m', > '\x1b[01mDevice Information Utility ver. 5.2\x1b[0m', > '', > 'Copyright (c) 2001-14 Hewlett-Packard Development Company, LP', > 'This software comes with ABSOLUTELY NO WARRANTY.', > 'This is free software, and you are welcome to distribute it', > 'under certain conditions. See COPYING file for more details.', > '', > '', > '\x1b[01mhp:/net/Deskjet_6940_series?ip=169.254.78.213\x1b[0m', > '', > '\x1b[01mDevice Parameters (dynamic data):\x1b[0m', > '\x1b[01m Parameter Value(s) \x1b[0m', > ' ---------------------------- ----------------------------------------------------------', > ' agent1-ack False ', > ' agent1-desc Black cartridge ', > ' agent1-dvc 0 ', > ' agent1-health 0 ', > ' agent1-health-desc Good/OK ', > ' agent1-hp-ink False ', > ' agent1-id 0 ', > ' agent1-kind 3 ', > ' agent1-known False ', > ' agent1-level 76 ', > ' agent1-level-trigger 0 ', > ' agent1-sku 96 (C8767WN) ', > ' agent1-type 1 ', > ' agent1-virgin False ', > ' agent2-ack False ', > ' agent2-desc Tri-color cartridge ', > ' agent2-dvc 0 ', > ' agent2-health 0 ', > ' agent2-health-desc Good/OK ', > ' agent2-hp-ink False ', > ' agent2-id 0 ', > ' agent2-kind 3 ', > ' agent2-known False ', > ' agent2-level 40 ', > ' agent2-level-trigger 0 ', > ' agent2-sku 95 (C8766WN)/97 (C9363WN) ', > ' agent2-type 2 ', > ' agent2-virgin False ', > ' back-end hp ', > " cups-printers ['Deskjet_6940'] ", > ' cups-uri hp:/net/Deskjet_6940_series?ip=169.254.78.213 ', > ' dev-file ', > ' device-state 1 ', > ' device-uri hp:/net/Deskjet_6940_series?ip=169.254.78.213 ', > ' deviceid MFG:HP;MDL:Deskjet 6940 ', > ' series;CMD:MLC,PCL,PML,DW-PCL,DESKJET,DYN;1284.4DL:4d,4e,1', > ' ;CLS:PRINTER;DES:6940;SN:MY8AKCK2JY04Q9;S:038000C484001021', > ' 002c180004cc2880028;J: ', > ' ;Z:0102,0503cbe9015549,0600;BT:000000000000,4465736B6A6574', > ' 2036393430207365 ', > ' duplexer 0 ', > ' error-state 0 ', > ' host 169.254.78.213 ', > ' in-tray1 True ', > ' in-tray2 False ', > ' is-hp True ', > ' media-path 3 ', > ' panel 0 ', > ' panel-line1 ', > ' panel-line2 ', > ' photo-tray 0 ', > ' port 1 ', > ' r 2 ', > ' revision 3 ', > ' rg 000 ', > ' rr 000002 ', > ' rs 000000002 ', > ' serial MY8AKCK2JY04Q9 ', > ' status-code 1000 ', > ' status-desc Idle ', > ' supply-door 0 ', > ' top-door 1 ', > '\x1b[01m', > 'Model Parameters (static data):\x1b[0m', > '\x1b[01m Parameter Value(s) \x1b[0m', > ' ---------------------------- ----------------------------------------------------------', > ' align-type 1 ', > ' clean-type 1 ', > ' color-cal-type 3 ', > ' copy-type 0 ', > ' embedded-server-type 1 ', > ' fax-type 0 ', > ' fw-download False ', > ' icon Deskjet_6500.png ', > ' io-mfp-mode 6 ', > ' io-mode 1 ', > ' io-support 6 ', > ' job-storage 0 ', > ' linefeed-cal-type 0 ', > ' model Deskjet_6940_series ', > ' model-ui HP Deskjet 6940 Series ', > ' model1 HP Deskjet 6940 Printer ', > ' model2 HP Deskjet 6940dt Printer ', > ' model3 HP Deskjet 6943 Printer ', > ' monitor-type 0 ', > ' panel-check-type 0 ', > ' pcard-type 0 ', > ' plugin 0 ', > ' plugin-reason 0 ', > ' power-settings 0 ', > ' pq-diag-type 0 ', > ' r-type 1 ', > ' r0-agent1-kind 3 ', > ' r0-agent1-sku 96 (C8767WN) ', > ' r0-agent1-type 1 ', > ' r0-agent2-kind 3 ', > ' r0-agent2-sku 95 (C8766WN)/97 (C9363WN) ', > ' r0-agent2-type 2 ', > ' r0-agent3-kind 3 ', > ' r0-agent3-sku 99 (C9369WN) ', > ' r0-agent3-type 3 ', > ' r0-agent4-kind 3 ', > ' r0-agent4-sku 100 (C9368AN) ', > ' r0-agent4-type 10 ', > ' r1-agent1-kind 3 ', > ' r1-agent1-sku 96 (C8767WN) ', > ' r1-agent1-type 1 ', > ' r1-agent2-kind 3 ', > ' r1-agent2-sku 95 (C8766WN)/97 (C9363WN) ', > ' r1-agent2-type 2 ', > ' r1-agent3-kind 3 ', > ' r1-agent3-sku 99 (C9369WN) ', > ' r1-agent3-type 3 ', > ' r1-agent4-kind 3 ', > ' r1-agent4-sku 100 (C9368AN) ', > ' r1-agent4-type 10 ', > ' r2-agent1-kind 3 ', > ' r2-agent1-sku 96 (C8767WN) ', > ' r2-agent1-type 1 ', > ' r2-agent2-kind 3 ', > ' r2-agent2-sku 95 (C8766WN)/97 (C9363WN) ', > ' r2-agent2-type 2 ', > ' r2-agent3-kind 3 ', > ' r2-agent3-sku 99 (C9369WN) ', > ' r2-agent3-type 3 ', > ' r2-agent4-kind 3 ', > ' r2-agent4-sku 100 (C9368AN) ', > ' r2-agent4-type 10 ', > ' r3-agent1-kind 3 ', > ' r3-agent1-sku 96 (C8767WN) ', > ' r3-agent1-type 1 ', > ' r3-agent2-kind 3 ', > ' r3-agent2-sku 95 (C8766WN)/97 (C9363WN) ', > ' r3-agent2-type 2 ', > ' r3-agent3-kind 3 ', > ' r3-agent3-sku 99 (C9369WN) ', > ' r3-agent3-type 3 ', > ' r3-agent4-kind 3 ', > ' r3-agent4-sku 100 (C9368AN) ', > ' r3-agent4-type 10 ', > ' r4-agent1-kind 3 ', > ' r4-agent1-sku 339 (C8767EN) ', > ' r4-agent1-type 1 ', > ' r4-agent2-kind 3 ', > ' r4-agent2-sku 344 (C9363EN)/343 (C8766EN) ', > ' r4-agent2-type 2 ', > ' r4-agent3-kind 3 ', > ' r4-agent3-sku 348 (C9369EN) ', > ' r4-agent3-type 3 ', > ' r4-agent4-kind 3 ', > ' r4-agent4-sku 100 (C9368AN) ', > ' r4-agent4-type 10 ', > ' r5-agent1-kind 3 ', > ' r5-agent1-sku 130 (C8765HN) ', > ' r5-agent1-type 1 ', > ' r5-agent2-kind 3 ', > ' r5-agent2-sku 134 (C8766HN)/135 (C9363HN) ', > ' r5-agent2-type 2 ', > ' r5-agent3-kind 3 ', > ' r5-agent3-sku 138 (C9369HN) ', > ' r5-agent3-type 3 ', > ' r5-agent4-kind 3 ', > ' r5-agent4-sku 100 (C9368AN) ', > ' r5-agent4-type 10 ', > ' r6-agent1-kind 3 ', > ' r6-agent1-sku 130 (C8765HN) ', > ' r6-agent1-type 1 ', > ' r6-agent2-kind 3 ', > ' r6-agent2-sku 134 (C8766HN)/135 (C9363HN) ', > ' r6-agent2-type 2 ', > ' r6-agent3-kind 3 ', > ' r6-agent3-sku 138 (C9369HN) ', > ' r6-agent3-type 3 ', > ' r6-agent4-kind 3 ', > ' r6-agent4-sku 100 (C9368AN) ', > ' r6-agent4-type 10 ', > ' r7-agent1-kind 3 ', > ' r7-agent1-sku 853 (C8765ZN) ', > ' r7-agent1-type 1 ', > ' r7-agent2-kind 3 ', > ' r7-agent2-sku 857 (C9363ZN)/855 (C8766ZN) ', > ' r7-agent2-type 2 ', > ' r7-agent3-kind 3 ', > ' r7-agent3-sku 858 (C9369ZN) ', > ' r7-agent3-type 3 ', > ' r7-agent4-kind 3 ', > ' r7-agent4-sku 100 (C9368AN) ', > ' r7-agent4-type 10 ', > ' scan-src 0 ', > ' scan-type 0 ', > ' status-battery-check 0 ', > ' status-dynamic-counters 1 ', > ' status-type 2 ', > ' support-released True ', > ' support-subtype 2202411 ', > ' support-type 2 ', > ' support-ver 0.9.8 ', > " tech-class ['DJGenericVIP'] ", > " tech-subclass ['Normal'] ", > ' tech-type 2 ', > ' usb-pid 35076 ', > ' usb-vid 1008 ', > ' wifi-config 0 ', > '\x1b[01m', > 'Status History (most recent first):\x1b[0m', > '\x1b[01m Date/Time Code Status Description User Job ID \x1b[0m', > ' -------------------- ----- ---------------------------------------- -------- --------', > ' 09/19/12 05:03:47 1000 Idle bob 0 ', > '', > '', > 'Done.', > ''], > ['\x1b[35;01mwarning: No display found.\x1b[0m', > '\x1b[31;01merror: hp-info -u/--gui requires Qt4 GUI support. Entering interactive mode.\x1b[0m', > ''], > 0), > 'is_cups_class': False, > 'local_cups_queue_attributes': {'auth-info-required': u'none', > 'charset-configured': u'utf-8', > 'charset-supported': [u'us-ascii', u'utf-8'], > 'color-supported': True, > 'compression-supported': [u'none', u'gzip'], > 'copies-default': 1, > 'copies-supported': (1, 9999), > 'cups-version': u'1.5.4', > 'device-uri': u'hp:/net/Deskjet_6940_series?ip=169.254.78.213', > '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-pdf', > u'application/vnd.cups-postscript', > u'application/vnd.cups-raster', > 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, 51606140), > '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, 51606140), > 'jpeg-x-dimension-supported': (0, 65535), > 'jpeg-y-dimension-supported': (1, 65535), > 'marker-change-time': 0, > 'media-bottom-margin-supported': [318, > 0, > 953, > 1270, > 141, > 1482, > 1376, > 1446], > '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': [318, 0, 141], > 'media-right-margin-supported': [318, > 0, > 141], > 'media-source-supported': [u'auto', > u'photo', > u'top', > u'bottom', > u'envelope', > u'large-capacity', > u'manual', > u'by-pass-tray', > u'cddvdtray'], > 'media-supported': [u'oe_card3x5_3x5in', > u'om_card3x5-fb_79.73x130.53mm', > u'om_hagaki_100.19x148.17mm', > u'om_hagaki-fb_103.72x151.69mm', > u'om_hagaki-duplex_100.19x144.99mm', > u'oe_photo4x6_4x6in', > u'om_photo4x6-fb_105.13x155.93mm', > u'iso_a6_105x148mm', > u'om_a6-fb_108.3x151.69mm', > u'om_a6-duplex_104.78x144.99mm', > u'oe_photo5x7_5x7in', > u'om_photo5x7-fb_130.53x181.33mm', > u'oe_card5x8_5x8in', > u'om_card5x8-duplex_127x200.03mm', > u'om_oufuku_200.03x148.17mm', > u'om_oufuku-fb_203.55x151.69mm', > u'om_oufuku-duplex_200.03x144.99mm', > u'iso_a5_148x210mm', > u'om_a5-fb_151.69x213.43mm', > u'om_a5-duplex_148.17x206.73mm', > u'jis_b5_182x257mm', > u'om_b5-duplex_176.04x246.59mm', > u'om_jb5_182.12x257.05mm', > u'om_jb5-fb_185.56x260.7mm', > u'om_jb5-duplex_182.03x254mm', > u'na_executive_7.25x10.5in', > u'om_executive-duplex_184.15x263.53mm', > u'oe_16k_7.75x10.75in', > u'na_govt-letter_8x10in', > u'na_letter_8.5x11in', > u'om_letter-fb_219.43x282.93mm', > u'om_letter-duplex_215.9x276.23mm', > u'iso_a4_210x297mm', > u'om_a4-fb_213.43x300.57mm', > u'om_a4-duplex_209.9x293.86mm', > u'oe_executive-jis_8.5x13in', > u'na_legal_8.5x14in', > u'om_legal-duplex_215.9x352.43mm', > u'om_cddvd80_83.96x83.96mm', > u'oe_cddvd120_5x5in', > u'om_env-a2_111x146.05mm', > u'iso_c6_114x162mm', > u'jpn_chou4_90x205mm', > u'na_monarch_3.875x7.5in', > u'iso_dl_110x220mm', > u'na_number-10_4.125x9.5in', > u'jpn_chou3_120x235mm', > u'iso_c5_162x229mm', > u'custom_min_1x4in', > u'custom_max_8.5x14in'], > 'media-top-margin-supported': [318, > 0, > 1270, > 141], > 'media-type-supported': [u'auto', > u'stationery', > u'photographic-glossy', > u'transparency', > u'cddvdmedia'], > 'multiple-document-handling-supported': [u'separate-documents-uncollated-copies', > u'separate-documents-collated-copies'], > 'multiple-document-jobs-supported': True, > 'multiple-operation-time-out': 300, > 'natural-language-configured': u'en-us', > 'notify-attributes-supported': [u'printer-state-change-time', > u'notify-lease-expiration-time', > u'notify-subscriber-user-name'], > 'notify-events-default': [u'job-completed'], > 'notify-events-supported': [u'job-completed', > u'job-config-changed', > u'job-created', > u'job-progress', > u'job-state-changed', > u'job-stopped', > u'printer-added', > u'printer-changed', > u'printer-config-changed', > u'printer-deleted', > u'printer-finishings-changed', > u'printer-media-changed', > u'printer-modified', > u'printer-restarted', > u'printer-shutdown', > u'printer-state-changed', > u'printer-stopped', > u'server-audit', > u'server-restarted', > u'server-started', > u'server-stopped'], > 'notify-lease-duration-default': 86400, > 'notify-lease-duration-supported': (0, > 2147483647), > 'notify-max-events-supported': [100], > 'notify-pull-method-supported': [u'ippget'], > 'notify-schemes-supported': [u'dbus', > u'mailto', > u'rss'], > 'number-up-default': 1, > 'number-up-supported': [1, 2, 4, 6, 9, 16], > 'operations-supported': [2, > 4, > 5, > 6, > 8, > 9, > 10, > 11, > 12, > 13, > 14, > 16, > 17, > 18, > 19, > 20, > 21, > 22, > 23, > 24, > 25, > 26, > 27, > 28, > 34, > 35, > 37, > 38, > 56, > 57, > 59, > 16385, > 16386, > 16387, > 16388, > 16389, > 16390, > 16391, > 16392, > 16393, > 16394, > 16395, > 16396, > 16397, > 16398, > 16399, > 16423], > 'orientation-requested-default': None, > 'orientation-requested-supported': [3, > 4, > 5, > 6], > 'output-bin-default': u'face-down', > 'output-bin-supported': [u'face-down'], > 'output-mode-default': u'color', > 'output-mode-supported': [u'monochrome', > u'color'], > 'page-ranges-supported': True, > 'pages-per-minute': 1, > 'pages-per-minute-color': 1, > 'pdf-k-octets-supported': (0, 51606140), > 'pdf-versions-supported': [u'adobe-1.2', > u'adobe-1.3', > u'adobe-1.4', > u'adobe-1.5', > u'adobe-1.6', > u'adobe-1.7', > u'iso-19005-1_2005', > u'iso-32000-1_2008', > u'pwg-5102.3'], > 'pdl-override-supported': [u'attempted'], > 'port-monitor': u'none', > 'port-monitor-supported': [u'none'], > 'print-color-mode-default': u'color', > 'print-color-mode-supported': [u'monochrome', > u'color'], > 'print-quality-default': 4, > 'print-quality-supported': [3, 4, 5], > 'printer-commands': u'none', > 'printer-current-time': '(IPP_TAG_DATE)', > 'printer-dns-sd-name': u'Deskjet_6940 @ localhost.localdomain', > '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/Deskjet_6940.png', > 'printer-info': u'Deskjet_6940', > 'printer-is-accepting-jobs': True, > 'printer-is-shared': True, > 'printer-location': u'', > 'printer-make-and-model': u'HP Deskjet 6940 Series, hpcups 3.12.9', > 'printer-more-info': u'http://localhost:631/printers/Deskjet_6940', > 'printer-name': u'Deskjet_6940', > 'printer-op-policy': u'default', > 'printer-op-policy-supported': [u'authenticated', > u'default'], > 'printer-resolution-default': (300, 300, 3), > 'printer-resolution-supported': [(300, > 300, > 3)], > 'printer-settable-attributes-supported': [u'printer-info', > u'printer-location'], > 'printer-state': 3, > 'printer-state-change-time': 1348009282, > 'printer-state-message': u'', > 'printer-state-reasons': [u'none'], > 'printer-type': 36892, > 'printer-up-time': 1348045426, > 'printer-uri-supported': [u'ipp://localhost:631/printers/Deskjet_6940'], > 'printer-uuid': u'urn:uuid:88f28f86-ba26-3a00-5458-e67d722e0f3f', > 'queued-job-count': 0, > 'server-is-sharing-printers': True, > 'sides-default': u'one-sided', > 'sides-supported': [u'one-sided', > u'two-sided-long-edge', > u'two-sided-short-edge'], > 'uri-authentication-supported': [u'requesting-user-name'], > 'uri-security-supported': [u'none'], > 'which-jobs-supported': [u'completed', > u'not-completed', > u'aborted', > u'all', > u'canceled', > u'pending', > u'pending-held', > u'processing', > u'processing-stopped']}} >Page 4 (Check PPD sanity): >{'cups_printer_ppd_defaults': {u'General': {u'ColorModel': u'RGB', > u'Duplex': u'None', > u'InputSlot': u'Auto', > u'MediaType': u'Automatic', > u'OutputMode': u'Normal', > u'PageRegion': u'Letter', > u'PageSize': u'Letter'}, > u'InstallableOptions': {u'OptionDuplex': u'False'}}, > 'cups_printer_ppd_valid': True, > 'missing_pkgs_and_exes': ([], [])} >Page 5 (Local or remote?): >{'printer_is_remote': False} >Page 6 (Verify packages): >{'packages_verification': {'cups': ['.M....... c /etc/cups/subscriptions.conf', > '..?...... /usr/lib/cups/backend/dnssd', > '..?...... /usr/lib/cups/backend/ipp', > '..?...... /usr/lib/cups/backend/lpd', > '..?...... /usr/lib/cups/backend/serial'], > 'foomatic': ['package foomatic is not installed'], > 'gutenprint': [], > 'hpijs': [], > 'hplip': ['..?...... /usr/lib/cups/backend/hpfax'], > 'system-config-printer': []}} >Page 7 (Error log checkpoint): >{'cups_server_settings': {'BrowseLocalProtocols': 'CUPS dnssd', > 'BrowseRemoteProtocols': 'CUPS', > 'DefaultAuthType': 'Basic', > 'JobPrivateAccess': 'default', > 'JobPrivateValues': 'default', > 'MaxLogSize': '0', > 'SubscriptionPrivateAccess': 'default', > 'SubscriptionPrivateValues': 'default', > 'SystemGroup': 'sys root', > 'WebInterface': 'Yes', > '_debug_logging': '1', > '_remote_admin': '0', > '_remote_any': '0', > '_remote_printers': '1', > '_share_printers': '1', > '_user_cancel_any': '0'}, > 'error_log_checkpoint': 3104607} >Page 8 (Print test page): >{'test_page_attempted': '19/Sep/2012:05:04:43 +0000', > 'test_page_job_id': [32], > 'test_page_job_status': [(True, > 32, > 'Deskjet_6940', > 'Test Page', > 'Stopped', > {'attributes-charset': u'utf-8', > 'attributes-natural-language': u'en-us', > 'document-count': 1, > 'document-format': u'application/vnd.cups-banner', > 'job-hold-until': u'no-hold', > 'job-id': 32, > 'job-k-octets': 1, > 'job-media-progress': 0, > 'job-media-sheets-completed': 1, > 'job-more-info': u'http://localhost:631/jobs/32', > 'job-preserved': True, > 'job-printer-state-message': u'/usr/lib/cups/filter/gstoraster failed', > 'job-printer-state-reasons': [u'none'], > 'job-printer-up-time': 1348046888, > 'job-printer-uri': u'ipp://localhost:631/printers/Deskjet_6940', > 'job-priority': 50, > 'job-sheets': [u'none', u'none'], > 'job-state': 6, > 'job-state-reasons': u'job-stopped', > 'job-uri': u'ipp://localhost:631/jobs/32', > 'job-uuid': u'urn:uuid:3a38e200-0f72-391b-6e66-d2ad7429d35c', > 'printer-uri': u'ipp://localhost/printers/Deskjet_6940', > 'time-at-completed': None, > 'time-at-creation': 1348045483, > 'time-at-processing': 1348045483})], > 'test_page_successful': False} >Page 9 (Error log fetch): >{'error_log': ['D [19/Sep/2012:05:04:10 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"', > 'D [19/Sep/2012:05:04:10 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:10 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:04:10 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:10 -0400] cupsdReadClient: 29 1.1 Get-Jobs 1', > 'D [19/Sep/2012:05:04:10 -0400] Get-Jobs ipp://localhost/printers/', > 'D [19/Sep/2012:05:04:10 -0400] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost', > 'D [19/Sep/2012:05:04:10 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"', > 'D [19/Sep/2012:05:04:10 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:10 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:04:10 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:10 -0400] cupsdReadClient: 29 1.1 Get-Jobs 1', > 'D [19/Sep/2012:05:04:10 -0400] Get-Jobs ipp://localhost/printers/', > 'D [19/Sep/2012:05:04:10 -0400] [Job 7] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 9] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 18] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 19] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 20] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 21] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 22] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 23] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 24] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 25] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 26] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 27] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 28] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 29] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 30] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] [Job 31] Loading attributes...', > 'D [19/Sep/2012:05:04:10 -0400] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost', > 'D [19/Sep/2012:05:04:10 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"', > 'D [19/Sep/2012:05:04:10 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:10 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:04:10 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:10 -0400] cupsdReadClient: 29 1.1 Create-Printer-Subscription 1', > 'D [19/Sep/2012:05:04:10 -0400] Create-Printer-Subscription /', > 'D [19/Sep/2012:05:04:10 -0400] cupsdCreateSubscription(con=0x7fdc1fdc4730(29), uri="/")', > 'D [19/Sep/2012:05:04:10 -0400] pullmethod="ippget"', > 'D [19/Sep/2012:05:04:10 -0400] notify-lease-duration=86400', > 'D [19/Sep/2012:05:04:10 -0400] notify-time-interval=0', > 'D [19/Sep/2012:05:04:10 -0400] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")', > 'D [19/Sep/2012:05:04:10 -0400] Added subscription #130 for server.', > 'D [19/Sep/2012:05:04:10 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:04:10 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"', > 'D [19/Sep/2012:05:04:10 -0400] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost', > 'D [19/Sep/2012:05:04:10 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:04:11 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:11 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:04:11 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:11 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:04:11 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:04:11 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:04:11 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:04:11 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:04:25 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:25 -0400] cupsdAcceptClient: 36 from localhost (Domain)', > 'D [19/Sep/2012:05:04:25 -0400] cupsdReadClient: 36 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:25 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:04:25 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:25 -0400] cupsdReadClient: 36 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:04:25 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:04:25 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:04:25 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:04:25 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:04:25 -0400] cupsdReadClient: 36 WAITING Closing on EOF', > 'D [19/Sep/2012:05:04:25 -0400] cupsdCloseClient: 36', > 'D [19/Sep/2012:05:04:25 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:04:31 -0400] cupsdReadClient: 34 WAITING Closing on EOF', > 'D [19/Sep/2012:05:04:31 -0400] cupsdCloseClient: 34', > 'D [19/Sep/2012:05:04:31 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'I [19/Sep/2012:05:04:41 -0400] Saving subscriptions.conf...', > 'D [19/Sep/2012:05:04:42 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: 34 from localhost (Domain)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 34 POST /printers/Deskjet_6940 HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 34 1.1 Print-Job 1', > 'D [19/Sep/2012:05:04:43 -0400] Print-Job ipp://localhost/printers/Deskjet_6940', > 'D [19/Sep/2012:05:04:43 -0400] [Job ???] Auto-typing file...', > 'I [19/Sep/2012:05:04:43 -0400] [Job ???] Request file type is application/vnd.cups-banner.', > 'D [19/Sep/2012:05:04:43 -0400] add_job: setting context of job to UNKNOWN SL', > 'D [19/Sep/2012:05:04:43 -0400] cupsdMarkDirty(----J-)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"', > 'D [19/Sep/2012:05:04:43 -0400] add_job: requesting-user-name="bob"', > 'D [19/Sep/2012:05:04:43 -0400] Adding default job-sheets values "none,none"...', > 'I [19/Sep/2012:05:04:43 -0400] [Job 32] Adding start banner page "none".', > 'D [19/Sep/2012:05:04:43 -0400] Notifier dbus started - PID = 2219', > 'D [19/Sep/2012:05:04:43 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdMarkDirty(----J-)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'I [19/Sep/2012:05:04:43 -0400] [Job 32] Adding end banner page "none".', > 'I [19/Sep/2012:05:04:43 -0400] [Job 32] File of type application/vnd.cups-banner queued by "bob".', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] hold_until=0', > 'I [19/Sep/2012:05:04:43 -0400] [Job 32] Queued on "Deskjet_6940" by "bob".', > 'D [19/Sep/2012:05:04:43 -0400] cupsdMarkDirty(----J-)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] job-sheets=none,none', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] argv[0]="Deskjet_6940"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] argv[1]="32"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] argv[2]="bob"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] argv[3]="Test Page"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] argv[4]="1"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] argv[5]="job-uuid=urn:uuid:3a38e200-0f72-391b-6e66-d2ad7429d35c job-originating-host-name=localhost time-at-creation=1348045483 time-at-processing=1348045483"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] argv[6]="/var/spool/cups/d00032-001"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[0]="CUPS_CACHEDIR=/var/cache/cups"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[1]="CUPS_DATADIR=/usr/share/cups"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[6]="CUPS_SERVERROOT=/etc/cups"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[7]="CUPS_STATEDIR=/var/run/cups"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[8]="HOME=/var/spool/cups/tmp"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[10]="SERVER_ADMIN=root@localhost.localdomain"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[11]="SOFTWARE=CUPS/1.5.4"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[12]="TMPDIR=/var/spool/cups/tmp"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[13]="USER=root"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[14]="CUPS_MAX_MESSAGE=2047"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[16]="CUPS_ENCRYPTION=IfRequested"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[17]="IPP_PORT=631"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[18]="CHARSET=utf-8"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[19]="LANG=en_US.UTF-8"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[20]="PPD=/etc/cups/ppd/Deskjet_6940.ppd"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[21]="RIP_MAX_CACHE=128m"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[22]="CONTENT_TYPE=application/vnd.cups-banner"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[23]="DEVICE_URI=hp:/net/Deskjet_6940_series?ip=169.254.78.213"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[24]="PRINTER_INFO=Deskjet_6940"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[25]="PRINTER_LOCATION="', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[26]="PRINTER=Deskjet_6940"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[27]="PRINTER_STATE_REASONS=none"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[28]="CUPS_FILETYPE=document"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[29]="FINAL_CONTENT_TYPE=printer/Deskjet_6940"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[30]="AUTH_I****"', > 'I [19/Sep/2012:05:04:43 -0400] [Job 32] Started filter /usr/lib/cups/filter/bannertops (PID 2220)', > 'I [19/Sep/2012:05:04:43 -0400] [Job 32] Started filter /usr/lib/cups/filter/pstops (PID 2221)', > 'I [19/Sep/2012:05:04:43 -0400] [Job 32] Started filter /usr/lib/cups/filter/gstoraster (PID 2222)', > 'I [19/Sep/2012:05:04:43 -0400] [Job 32] Started filter /usr/lib/cups/filter/hpcups (PID 2223)', > 'I [19/Sep/2012:05:04:43 -0400] [Job 32] Started backend /usr/lib/cups/backend/hp (PID 2224)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP successful-ok for Print-Job (ipp://localhost/printers/Deskjet_6940) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] [Notifier] state=3', > 'D [19/Sep/2012:05:04:43 -0400] [Notifier] Connected to D-BUS', > 'D [19/Sep/2012:05:04:43 -0400] [Notifier] JobCreated', > 'D [19/Sep/2012:05:04:43 -0400] [Notifier] state=3', > 'D [19/Sep/2012:05:04:43 -0400] [Notifier] PrinterStateChanged', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: 42 from localhost (Domain)', > 'D [19/Sep/2012:05:04:43 -0400] [Notifier] state=3', > 'D [19/Sep/2012:05:04:43 -0400] [Notifier] JobState', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 42 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 42 1.1 Get-Job-Attributes 1', > 'D [19/Sep/2012:05:04:43 -0400] Get-Job-Attributes ipp://localhost/jobs/32', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/32) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: 43 from localhost (Domain)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 43 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 43 1.1 Get-Job-Attributes 1', > 'D [19/Sep/2012:05:04:43 -0400] Get-Job-Attributes ipp://localhost/jobs/32', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/32) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: 44 from localhost (Domain)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 44 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 44 1.1 CUPS-Get-Printers 1', > 'D [19/Sep/2012:05:04:43 -0400] CUPS-Get-Printers', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 27 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 27 1.1 CUPS-Get-Default 1', > 'D [19/Sep/2012:05:04:43 -0400] CUPS-Get-Default', > 'D [19/Sep/2012:05:04:43 -0400] CUPS-Get-Default client-error-not-found: No default printer.', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: 45 from localhost (Domain)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 45 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 45 1.1 CUPS-Get-Printers 1', > 'D [19/Sep/2012:05:04:43 -0400] CUPS-Get-Printers', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 27 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 27 1.1 Get-Jobs 1', > 'D [19/Sep/2012:05:04:43 -0400] Get-Jobs ipp://localhost/', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] load_banner(filename="/var/spool/cups/d00032-001")', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] 1 #CUPS-BANNER', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] 2 Show printer-name printer-info printer-location printer-make-and-model printer-driver-name printer-driver-version paper-size imageable-area', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] 3 Header Printer Test Page', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] 4 Footer Printer Test Page', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] 5 Notice CUPS 1.5.4.', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] 6 Image images/cups.png', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] 7 Image images/color-wheel.png', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Page = 612x792; 9,9 to 603,783', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] STATE: -marker-supply-low-warning', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Page = 612x792; 9,9 to 603,783', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] slow_collate=0, slow_duplex=0, slow_order=0', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Before copy_comments - %!PS-Adobe-3.0', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %!PS-Adobe-3.0', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%BoundingBox: 9 9 603 783', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %cupsRotation: 0', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%Creator: bannertops/CUPS v1.5.4', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%CreationDate: Wed 19 Sep 2012 05:04:43 AM EDT', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%LanguageLevel: 2', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%DocumentData: Clean7Bit', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%Title: (Test Page)', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%For: (bob)', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%Pages: 1', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%DocumentSuppliedResources: font Monospace', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%+ font Monospace-Bold', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%+ font Monospace-BoldOblique', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%+ font Monospace-Oblique', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] %%EndComments', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Before copy_prolog - %%BeginProlog', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] PNG image: 128x128x8, color_type=6 (RGB+ALPHA)', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] PNG image: 192x128x8, color_type=2 (RGB)', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Before copy_setup - %%Page: coverpage 1', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Before page loop - %%Page: coverpage 1', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Copying page 1...', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] pagew = 594.0, pagel = 774.0', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] PageLeft = 9.0, PageRight = 603.0', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] PageTop = 783.0, PageBottom = 9.0', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] PageWidth = 612.0, PageLength = 792.0', > 'D [19/Sep/2012:05:04:43 -0400] PID 2220 (/usr/lib/cups/filter/bannertops) exited with no errors.', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Wrote 1 pages...', > "D [19/Sep/2012:05:04:43 -0400] [Job 32] PPD uses qualifier 'RGB.Automatic.'", > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Calling FindDeviceById(Deskjet_6940)', > "D [19/Sep/2012:05:04:43 -0400] [Job 32] Failed to send: org.freedesktop.ColorManager.Failed:device id 'Deskjet_6940' does not exists", > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Failed to get profile filename!', > 'I [19/Sep/2012:05:04:43 -0400] [Job 32] no profiles specified in PPD', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Set job-printer-state-message to "no profiles specified in PPD", current level=INFO', > 'D [19/Sep/2012:05:04:43 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] [Notifier] state=3', > 'D [19/Sep/2012:05:04:43 -0400] [Notifier] PrinterStateChanged', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: 46 from localhost (Domain)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 46 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 46 1.1 CUPS-Get-Printers 1', > 'D [19/Sep/2012:05:04:43 -0400] CUPS-Get-Printers', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] Ghostscript command line: /usr/bin/gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -sDEVICE=cups -sstdout=%stderr -sOutputFile=%stdout -I/usr/share/cups/fonts -c -f -_', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[0]="CUPS_CACHEDIR=/var/cache/cups"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[1]="CUPS_DATADIR=/usr/share/cups"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[6]="CUPS_SERVERROOT=/etc/cups"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[7]="CUPS_STATEDIR=/var/run/cups"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 46 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 46 1.1 CUPS-Get-Default 1', > 'D [19/Sep/2012:05:04:43 -0400] CUPS-Get-Default', > 'D [19/Sep/2012:05:04:43 -0400] CUPS-Get-Default client-error-not-found: No default printer.', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[8]="HOME=/var/spool/cups/tmp"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[10]="SERVER_ADMIN=root@localhost.localdomain"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[11]="SOFTWARE=CUPS/1.5.4"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[12]="TMPDIR=/var/spool/cups/tmp"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[13]="USER=root"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[14]="CUPS_MAX_MESSAGE=2047"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[16]="CUPS_ENCRYPTION=IfRequested"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[17]="IPP_PORT=631"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[18]="CHARSET=utf-8"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[19]="LANG=en_US.UTF-8"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[20]="PPD=/etc/cups/ppd/Deskjet_6940.ppd"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[21]="RIP_MAX_CACHE=128m"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[22]="CONTENT_TYPE=application/vnd.cups-banner"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[23]="DEVICE_URI=hp:/net/Deskjet_6940_series?ip=169.254.78.213"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[24]="PRINTER_INFO=Deskjet_6940"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[25]="PRINTER_LOCATION="', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[26]="PRINTER=Deskjet_6940"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[27]="PRINTER_STATE_REASONS=none"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[28]="CUPS_FILETYPE=document"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[29]="FINAL_CONTENT_TYPE=printer/Deskjet_6940"', > 'D [19/Sep/2012:05:04:43 -0400] [Job 32] envp[30]="AUTH_INFO_REQUIRED=none"', > 'D [19/Sep/2012:05:04:43 -0400] PID 2221 (/usr/lib/cups/filter/pstops) exited with no errors.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAcceptClient: 47 from localhost (Domain)', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 47 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 47 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:04:43 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:04:43 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 47 WAITING Closing on EOF', > 'D [19/Sep/2012:05:04:43 -0400] cupsdCloseClient: 47', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:04:43 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:04:43 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 17 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 17 1.1 CUPS-Get-Printers 1', > 'D [19/Sep/2012:05:04:43 -0400] CUPS-Get-Printers', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 17 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 17 1.1 CUPS-Get-Classes 1', > 'D [19/Sep/2012:05:04:43 -0400] CUPS-Get-Classes', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 17 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:43 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:43 -0400] cupsdReadClient: 17 1.1 CUPS-Get-Default 1', > 'D [19/Sep/2012:05:04:43 -0400] CUPS-Get-Default', > 'D [19/Sep/2012:05:04:43 -0400] CUPS-Get-Default client-error-not-found: No default printer.', > 'D [19/Sep/2012:05:04:43 -0400] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost', > 'D [19/Sep/2012:05:04:43 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'I [19/Sep/2012:05:04:44 -0400] [Job 32] Start rendering...', > 'D [19/Sep/2012:05:04:44 -0400] [Job 32] Set job-printer-state-message to "Start rendering...", current level=INFO', > 'I [19/Sep/2012:05:04:44 -0400] [Job 32] Processing page 1...', > 'D [19/Sep/2012:05:04:44 -0400] [Job 32] Set job-printer-state-message to "Processing page 1...", current level=INFO', > 'D [19/Sep/2012:05:04:44 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] [Notifier] state=3', > 'D [19/Sep/2012:05:04:44 -0400] [Notifier] PrinterStateChanged', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 1.1 CUPS-Get-Printers 1', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Printers', > 'D [19/Sep/2012:05:04:44 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 1.1 CUPS-Get-Default 1', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Default', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Default client-error-not-found: No default printer.', > 'D [19/Sep/2012:05:04:44 -0400] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAcceptClient: 47 from localhost (Domain)', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 47 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 47 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:04:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:04:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:04:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 47 WAITING Closing on EOF', > 'D [19/Sep/2012:05:04:44 -0400] cupsdCloseClient: 47', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:04:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:04:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:04:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 17 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 17 1.1 CUPS-Get-Printers 1', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Printers', > 'D [19/Sep/2012:05:04:44 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 17 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 17 1.1 CUPS-Get-Classes 1', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Classes', > 'D [19/Sep/2012:05:04:44 -0400] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 17 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 17 1.1 CUPS-Get-Default 1', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Default', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Default client-error-not-found: No default printer.', > 'D [19/Sep/2012:05:04:44 -0400] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] [Job 32] STATE: +connecting-to-device', > 'D [19/Sep/2012:05:04:44 -0400] [Job 32] PAGE: 1 1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] [Notifier] state=3', > 'D [19/Sep/2012:05:04:44 -0400] [Notifier] PrinterStateChanged', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 1.1 CUPS-Get-Printers 1', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Printers', > 'D [19/Sep/2012:05:04:44 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 1.1 CUPS-Get-Default 1', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Default', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Default client-error-not-found: No default printer.', > 'D [19/Sep/2012:05:04:44 -0400] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] [Job 32] STATE: -connecting-to-device', > 'D [19/Sep/2012:05:04:44 -0400] [Job 32] STATE: -media-empty-error,media-jam-error,hplip.plugin-error,cover-open-error,toner-empty-error,other', > 'D [19/Sep/2012:05:04:44 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] [Notifier] state=3', > 'D [19/Sep/2012:05:04:44 -0400] [Notifier] PrinterStateChanged', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 1.1 CUPS-Get-Printers 1', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Printers', > 'D [19/Sep/2012:05:04:44 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:44 -0400] cupsdReadClient: 46 1.1 CUPS-Get-Default 1', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Default', > 'D [19/Sep/2012:05:04:44 -0400] CUPS-Get-Default client-error-not-found: No default printer.', > 'D [19/Sep/2012:05:04:44 -0400] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost', > 'D [19/Sep/2012:05:04:44 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:45 -0400] cupsdAcceptClient: 47 from localhost (Domain)', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 47 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 47 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:04:45 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:04:45 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:04:45 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:45 -0400] cupsdAcceptClient: 48 from localhost (Domain)', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 34 WAITING Closing on EOF', > 'D [19/Sep/2012:05:04:45 -0400] cupsdCloseClient: 34', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:04:45 -0400] cupsdAcceptClient: 34 from localhost (Domain)', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 47 WAITING Closing on EOF', > 'D [19/Sep/2012:05:04:45 -0400] cupsdCloseClient: 47', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:04:45 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:04:45 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:04:45 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 17 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 17 1.1 CUPS-Get-Printers 1', > 'D [19/Sep/2012:05:04:45 -0400] CUPS-Get-Printers', > 'D [19/Sep/2012:05:04:45 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 17 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 17 1.1 CUPS-Get-Classes 1', > 'D [19/Sep/2012:05:04:45 -0400] CUPS-Get-Classes', > 'D [19/Sep/2012:05:04:45 -0400] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 17 POST / HTTP/1.1', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:04:45 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:04:45 -0400] cupsdReadClient: 17 1.1 CUPS-Get-Default 1', > 'D [19/Sep/2012:05:04:45 -0400] CUPS-Get-Default', > 'D [19/Sep/2012:05:04:45 -0400] CUPS-Get-Default client-error-not-found: No default printer.', > 'D [19/Sep/2012:05:04:45 -0400] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost', > 'D [19/Sep/2012:05:04:45 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [19/Sep/2012:05:05:04 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:05:04 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:05:04 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:05:04 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:05:04 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:05:04 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:05:04 -0400] Report: clients=27', > 'D [19/Sep/2012:05:05:04 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:05:04 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:05:04 -0400] Report: printers=2', > 'D [19/Sep/2012:05:05:04 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:05:04 -0400] Report: stringpool-string-count=24617', > 'D [19/Sep/2012:05:05:04 -0400] Report: stringpool-alloc-bytes=17264', > 'D [19/Sep/2012:05:05:04 -0400] Report: stringpool-total-bytes=459624', > 'I [19/Sep/2012:05:05:14 -0400] Saving job.cache...', > 'I [19/Sep/2012:05:05:14 -0400] Saving subscriptions.conf...', > 'D [19/Sep/2012:05:05:14 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:05:14 -0400] [Job 7] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 9] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 18] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 19] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 20] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 21] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 22] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 23] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 24] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 25] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 26] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 27] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 28] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 29] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 30] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] [Job 31] Unloading...', > 'D [19/Sep/2012:05:05:14 -0400] cupsdReadClient: 34 WAITING Closing on EOF', > 'D [19/Sep/2012:05:05:14 -0400] cupsdCloseClient: 34', > 'D [19/Sep/2012:05:05:14 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:05:45 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:05:45 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:05:45 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:05:45 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:05:45 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:05:45 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:05:45 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:05:45 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:06:06 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:06:06 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:06:06 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:06:06 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:06:06 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:06:06 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:06:06 -0400] Report: clients=26', > 'D [19/Sep/2012:05:06:06 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:06:06 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:06:06 -0400] Report: printers=2', > 'D [19/Sep/2012:05:06:06 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:06:06 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:06:06 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:06:06 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:06:45 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:06:45 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:06:45 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:06:45 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:06:45 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:06:45 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:06:45 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:06:45 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:07:08 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:07:08 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:07:08 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:07:08 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:07:08 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:07:08 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:07:08 -0400] Report: clients=26', > 'D [19/Sep/2012:05:07:08 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:07:08 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:07:08 -0400] Report: printers=2', > 'D [19/Sep/2012:05:07:08 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:07:08 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:07:08 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:07:08 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:07:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:07:44 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:07:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:07:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:07:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:07:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:07:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:07:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:08:10 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:08:10 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:08:10 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:08:10 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:08:10 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:08:10 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:08:10 -0400] Closing client 18 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:10 -0400] cupsdCloseClient: 18', > 'D [19/Sep/2012:05:08:10 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:10 -0400] Closing client 19 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:10 -0400] cupsdCloseClient: 19', > 'D [19/Sep/2012:05:08:10 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:10 -0400] Closing client 20 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:10 -0400] cupsdCloseClient: 20', > 'D [19/Sep/2012:05:08:10 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:10 -0400] Closing client 21 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:10 -0400] cupsdCloseClient: 21', > 'D [19/Sep/2012:05:08:10 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:10 -0400] Closing client 22 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:10 -0400] cupsdCloseClient: 22', > 'D [19/Sep/2012:05:08:10 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:10 -0400] Closing client 23 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:10 -0400] cupsdCloseClient: 23', > 'D [19/Sep/2012:05:08:10 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:10 -0400] Closing client 24 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:10 -0400] cupsdCloseClient: 24', > 'D [19/Sep/2012:05:08:10 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:10 -0400] Closing client 25 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:10 -0400] cupsdCloseClient: 25', > 'D [19/Sep/2012:05:08:10 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:10 -0400] Closing client 26 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:10 -0400] cupsdCloseClient: 26', > 'D [19/Sep/2012:05:08:10 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:10 -0400] Report: clients=17', > 'D [19/Sep/2012:05:08:10 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:08:10 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:08:10 -0400] Report: printers=2', > 'D [19/Sep/2012:05:08:10 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:08:10 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:08:10 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:08:10 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:08:22 -0400] Closing client 28 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:22 -0400] cupsdCloseClient: 28', > 'D [19/Sep/2012:05:08:22 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:41 -0400] Closing client 30 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:41 -0400] cupsdCloseClient: 30', > 'D [19/Sep/2012:05:08:41 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:41 -0400] Closing client 31 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:41 -0400] cupsdCloseClient: 31', > 'D [19/Sep/2012:05:08:41 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:41 -0400] Closing client 32 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:41 -0400] cupsdCloseClient: 32', > 'D [19/Sep/2012:05:08:41 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:08:44 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:08:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:08:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:08:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:08:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:08:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:08:48 -0400] Closing client 37 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:48 -0400] cupsdCloseClient: 37', > 'D [19/Sep/2012:05:08:48 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:48 -0400] Closing client 38 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:48 -0400] cupsdCloseClient: 38', > 'D [19/Sep/2012:05:08:48 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:48 -0400] Closing client 33 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:48 -0400] cupsdCloseClient: 33', > 'D [19/Sep/2012:05:08:48 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:08:59 -0400] Closing client 35 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:08:59 -0400] cupsdCloseClient: 35', > 'D [19/Sep/2012:05:08:59 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:09:13 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:09:13 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:09:13 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:09:13 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:09:13 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:09:13 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:09:13 -0400] Report: clients=9', > 'D [19/Sep/2012:05:09:13 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:09:13 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:09:13 -0400] Report: printers=2', > 'D [19/Sep/2012:05:09:13 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:09:13 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:09:13 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:09:13 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:09:44 -0400] Closing client 27 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:09:44 -0400] cupsdCloseClient: 27', > 'D [19/Sep/2012:05:09:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:09:44 -0400] Closing client 42 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:09:44 -0400] cupsdCloseClient: 42', > 'D [19/Sep/2012:05:09:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:09:44 -0400] Closing client 43 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:09:44 -0400] cupsdCloseClient: 43', > 'D [19/Sep/2012:05:09:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:09:44 -0400] Closing client 44 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:09:44 -0400] cupsdCloseClient: 44', > 'D [19/Sep/2012:05:09:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:09:44 -0400] Closing client 45 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:09:44 -0400] cupsdCloseClient: 45', > 'D [19/Sep/2012:05:09:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:09:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:09:44 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:09:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:09:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:09:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:09:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:09:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:09:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:09:45 -0400] Closing client 46 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:09:45 -0400] cupsdCloseClient: 46', > 'D [19/Sep/2012:05:09:45 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:09:46 -0400] Closing client 17 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:09:46 -0400] cupsdCloseClient: 17', > 'D [19/Sep/2012:05:09:46 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:09:46 -0400] Closing client 48 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:09:46 -0400] cupsdCloseClient: 48', > 'D [19/Sep/2012:05:09:46 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:10:16 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:10:16 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:10:16 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:10:16 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:10:16 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:10:16 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:10:16 -0400] Report: clients=1', > 'D [19/Sep/2012:05:10:16 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:10:16 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:10:16 -0400] Report: printers=2', > 'D [19/Sep/2012:05:10:16 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:10:16 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:10:16 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:10:16 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:10:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:10:44 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:10:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:10:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:10:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:10:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:10:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:10:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:11:19 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:11:19 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:11:19 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:11:19 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:11:19 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:11:19 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:11:19 -0400] Report: clients=1', > 'D [19/Sep/2012:05:11:19 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:11:19 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:11:19 -0400] Report: printers=2', > 'D [19/Sep/2012:05:11:19 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:11:19 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:11:19 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:11:19 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:11:45 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:11:45 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:11:45 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:11:45 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:11:45 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:11:45 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:11:45 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:11:45 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:12:21 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:12:21 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:12:21 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:12:21 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:12:21 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:12:21 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:12:21 -0400] Report: clients=1', > 'D [19/Sep/2012:05:12:21 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:12:21 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:12:21 -0400] Report: printers=2', > 'D [19/Sep/2012:05:12:21 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:12:21 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:12:21 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:12:21 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:12:45 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:12:45 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:12:45 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:12:45 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:12:45 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:12:45 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:12:45 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:12:45 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:13:23 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:13:23 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:13:23 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:13:23 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:13:23 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:13:23 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:13:23 -0400] Report: clients=1', > 'D [19/Sep/2012:05:13:23 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:13:23 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:13:23 -0400] Report: printers=2', > 'D [19/Sep/2012:05:13:23 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:13:23 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:13:23 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:13:23 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:13:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:13:44 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:13:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:13:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:13:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:13:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:13:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:13:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:14:26 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:14:26 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:14:26 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:14:26 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:14:26 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:14:26 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:14:26 -0400] Report: clients=1', > 'D [19/Sep/2012:05:14:26 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:14:26 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:14:26 -0400] Report: printers=2', > 'D [19/Sep/2012:05:14:26 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:14:26 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:14:26 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:14:26 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:14:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:14:44 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:14:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:14:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:14:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:14:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:14:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:14:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:15:29 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:15:29 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:15:29 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:15:29 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:15:29 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:15:29 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:15:29 -0400] Report: clients=1', > 'D [19/Sep/2012:05:15:29 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:15:29 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:15:29 -0400] Report: printers=2', > 'D [19/Sep/2012:05:15:29 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:15:29 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:15:29 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:15:29 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:15:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:15:44 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:15:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:15:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:15:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:15:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:15:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:15:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:16:32 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:16:32 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:16:32 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:16:32 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:16:32 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:16:32 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:16:32 -0400] Report: clients=1', > 'D [19/Sep/2012:05:16:32 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:16:32 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:16:32 -0400] Report: printers=2', > 'D [19/Sep/2012:05:16:32 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:16:32 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:16:32 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:16:32 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:16:45 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:16:45 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:16:45 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:16:45 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:16:45 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:16:45 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:16:45 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:16:45 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:17:34 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:17:34 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:17:34 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:17:34 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:17:34 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:17:34 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:17:34 -0400] Report: clients=1', > 'D [19/Sep/2012:05:17:34 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:17:34 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:17:34 -0400] Report: printers=2', > 'D [19/Sep/2012:05:17:34 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:17:34 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:17:34 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:17:34 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:17:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:17:44 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:17:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:17:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:17:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:17:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:17:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:17:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:18:37 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:18:37 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:18:37 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:18:37 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:18:37 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:18:37 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:18:37 -0400] Report: clients=1', > 'D [19/Sep/2012:05:18:37 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:18:37 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:18:37 -0400] Report: printers=2', > 'D [19/Sep/2012:05:18:37 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:18:37 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:18:37 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:18:37 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:18:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:18:44 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:18:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:18:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:18:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:18:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:18:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:18:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:19:39 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:19:39 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:19:39 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:19:39 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:19:39 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:19:39 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:19:39 -0400] Report: clients=1', > 'D [19/Sep/2012:05:19:39 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:19:39 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:19:39 -0400] Report: printers=2', > 'D [19/Sep/2012:05:19:39 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:19:39 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:19:39 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:19:39 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:19:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:19:44 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:19:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:19:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:19:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:19:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:19:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:19:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:20:41 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:20:41 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:20:41 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:20:41 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:20:41 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:20:41 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:20:41 -0400] Report: clients=1', > 'D [19/Sep/2012:05:20:41 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:20:41 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:20:41 -0400] Report: printers=2', > 'D [19/Sep/2012:05:20:41 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:20:41 -0400] Report: stringpool-string-count=23960', > 'D [19/Sep/2012:05:20:41 -0400] Report: stringpool-alloc-bytes=15512', > 'D [19/Sep/2012:05:20:41 -0400] Report: stringpool-total-bytes=446416', > 'D [19/Sep/2012:05:20:44 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:20:44 -0400] cupsdSetBusyState: newbusy="Active clients and printing jobs", busy="Printing jobs"', > 'D [19/Sep/2012:05:20:44 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:20:44 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:20:44 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:20:44 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:20:44 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:20:44 -0400] cupsdSetBusyState: newbusy="Printing jobs", busy="Active clients and printing jobs"', > 'D [19/Sep/2012:05:21:11 -0400] PID 2224 (/usr/lib/cups/backend/hp) did not catch or ignore signal 13.', > 'D [19/Sep/2012:05:21:11 -0400] PID 2223 (/usr/lib/cups/filter/hpcups) did not catch or ignore signal 13.', > 'D [19/Sep/2012:05:21:11 -0400] PID 2222 (/usr/lib/cups/filter/gstoraster) stopped with status 13.', > 'D [19/Sep/2012:05:21:11 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:21:11 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs"', > 'E [19/Sep/2012:05:21:11 -0400] [Job 32] Job stopped due to filter errors; please consult the error_log file for details.', > 'D [19/Sep/2012:05:21:11 -0400] cupsdMarkDirty(----J-)', > 'D [19/Sep/2012:05:21:11 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:21:11 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:21:11 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:21:11 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:21:11 -0400] [Notifier] state=3', > 'D [19/Sep/2012:05:21:11 -0400] [Notifier] JobState', > 'D [19/Sep/2012:05:21:11 -0400] [Notifier] state=3', > 'D [19/Sep/2012:05:21:11 -0400] [Notifier] PrinterStateChanged', > 'D [19/Sep/2012:05:21:11 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:21:11 -0400] cupsdAcceptClient: 17 from localhost (Domain)', > 'D [19/Sep/2012:05:21:11 -0400] cupsdReadClient: 17 POST / HTTP/1.1', > 'D [19/Sep/2012:05:21:11 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"', > 'D [19/Sep/2012:05:21:11 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:21:11 -0400] cupsdReadClient: 17 1.1 Get-Job-Attributes 1', > 'D [19/Sep/2012:05:21:11 -0400] Get-Job-Attributes ipp://localhost/jobs/32', > 'D [19/Sep/2012:05:21:11 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/32) from localhost', > 'D [19/Sep/2012:05:21:11 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:21:12 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:21:12 -0400] cupsdAcceptClient: 18 from localhost (Domain)', > 'D [19/Sep/2012:05:21:12 -0400] [Job 32] Unloading...', > 'D [19/Sep/2012:05:21:12 -0400] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [19/Sep/2012:05:21:12 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:21:12 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:21:12 -0400] cupsdReadClient: 18 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:21:12 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:21:12 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:21:12 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:21:12 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:21:12 -0400] cupsdReadClient: 18 WAITING Closing on EOF', > 'D [19/Sep/2012:05:21:12 -0400] cupsdCloseClient: 18', > 'D [19/Sep/2012:05:21:12 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:21:12 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:21:12 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:21:12 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:21:12 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:21:12 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:21:12 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:21:12 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:21:12 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:21:12 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:21:12 -0400] cupsdAcceptClient: 18 from localhost (Domain)', > 'D [19/Sep/2012:05:21:12 -0400] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [19/Sep/2012:05:21:12 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:21:12 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:21:12 -0400] cupsdReadClient: 18 1.1 CUPS-Get-Printers 1', > 'D [19/Sep/2012:05:21:12 -0400] CUPS-Get-Printers', > 'D [19/Sep/2012:05:21:12 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [19/Sep/2012:05:21:12 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:21:12 -0400] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [19/Sep/2012:05:21:12 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:21:12 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:21:12 -0400] cupsdReadClient: 18 1.1 CUPS-Get-Classes 1', > 'D [19/Sep/2012:05:21:12 -0400] CUPS-Get-Classes', > 'D [19/Sep/2012:05:21:12 -0400] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost', > 'D [19/Sep/2012:05:21:12 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:21:12 -0400] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [19/Sep/2012:05:21:12 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:21:12 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:21:12 -0400] cupsdReadClient: 18 1.1 CUPS-Get-Default 1', > 'D [19/Sep/2012:05:21:12 -0400] CUPS-Get-Default', > 'D [19/Sep/2012:05:21:12 -0400] CUPS-Get-Default client-error-not-found: No default printer.', > 'D [19/Sep/2012:05:21:12 -0400] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost', > 'D [19/Sep/2012:05:21:12 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'I [19/Sep/2012:05:21:42 -0400] Saving job.cache...', > 'I [19/Sep/2012:05:21:42 -0400] Saving subscriptions.conf...', > 'D [19/Sep/2012:05:21:42 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"', > 'D [19/Sep/2012:05:21:42 -0400] Report: clients=3', > 'D [19/Sep/2012:05:21:42 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:21:42 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:21:42 -0400] Report: printers=2', > 'D [19/Sep/2012:05:21:42 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:21:42 -0400] Report: stringpool-string-count=24037', > 'D [19/Sep/2012:05:21:42 -0400] Report: stringpool-alloc-bytes=15064', > 'D [19/Sep/2012:05:21:42 -0400] Report: stringpool-total-bytes=448192', > 'D [19/Sep/2012:05:21:43 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:21:43 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:21:43 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:21:43 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:21:43 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:21:43 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:22:11 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:22:11 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:22:11 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:22:11 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:22:11 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:22:11 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:22:11 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:22:11 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"', > 'D [19/Sep/2012:05:22:45 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:22:45 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:22:45 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:22:45 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:22:45 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:22:45 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:22:45 -0400] Report: clients=3', > 'D [19/Sep/2012:05:22:45 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:22:45 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:22:45 -0400] Report: printers=2', > 'D [19/Sep/2012:05:22:45 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:22:45 -0400] Report: stringpool-string-count=24037', > 'D [19/Sep/2012:05:22:45 -0400] Report: stringpool-alloc-bytes=15064', > 'D [19/Sep/2012:05:22:45 -0400] Report: stringpool-total-bytes=448192', > 'D [19/Sep/2012:05:23:11 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:23:11 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:23:11 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:23:11 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:23:11 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:23:11 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:23:11 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:23:11 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"', > 'D [19/Sep/2012:05:23:48 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:23:48 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:23:48 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:23:48 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:23:48 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:23:48 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:23:48 -0400] Report: clients=3', > 'D [19/Sep/2012:05:23:48 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:23:48 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:23:48 -0400] Report: printers=2', > 'D [19/Sep/2012:05:23:48 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:23:48 -0400] Report: stringpool-string-count=24037', > 'D [19/Sep/2012:05:23:48 -0400] Report: stringpool-alloc-bytes=15064', > 'D [19/Sep/2012:05:23:48 -0400] Report: stringpool-total-bytes=448192', > 'D [19/Sep/2012:05:24:11 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:24:11 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:24:11 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:24:11 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:24:11 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:24:11 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:24:11 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:24:11 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"', > 'D [19/Sep/2012:05:24:51 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:24:51 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:24:51 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:24:51 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:24:51 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:24:51 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:24:51 -0400] Report: clients=3', > 'D [19/Sep/2012:05:24:51 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:24:51 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:24:51 -0400] Report: printers=2', > 'D [19/Sep/2012:05:24:51 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:24:51 -0400] Report: stringpool-string-count=24037', > 'D [19/Sep/2012:05:24:51 -0400] Report: stringpool-alloc-bytes=15064', > 'D [19/Sep/2012:05:24:51 -0400] Report: stringpool-total-bytes=448192', > 'D [19/Sep/2012:05:25:11 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:25:11 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:25:11 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:25:11 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:25:11 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:25:11 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:25:11 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:25:11 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"', > 'D [19/Sep/2012:05:25:54 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:25:54 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:25:54 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:25:54 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:25:54 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:25:54 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:25:54 -0400] Report: clients=3', > 'D [19/Sep/2012:05:25:54 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:25:54 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:25:54 -0400] Report: printers=2', > 'D [19/Sep/2012:05:25:54 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:25:54 -0400] Report: stringpool-string-count=24037', > 'D [19/Sep/2012:05:25:54 -0400] Report: stringpool-alloc-bytes=15064', > 'D [19/Sep/2012:05:25:54 -0400] Report: stringpool-total-bytes=448192', > 'D [19/Sep/2012:05:26:11 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:26:11 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:26:11 -0400] cupsdAuthorize: No authentication data provided.', > 'E [19/Sep/2012:05:26:11 -0400] [Job 32] Stopping unresponsive job!', > 'D [19/Sep/2012:05:26:11 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:26:11 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:26:11 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:26:11 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:26:11 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"', > 'D [19/Sep/2012:05:26:12 -0400] Closing client 17 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:26:12 -0400] cupsdCloseClient: 17', > 'D [19/Sep/2012:05:26:12 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"', > 'D [19/Sep/2012:05:26:13 -0400] Closing client 18 after 300 seconds of inactivity...', > 'D [19/Sep/2012:05:26:13 -0400] cupsdCloseClient: 18', > 'D [19/Sep/2012:05:26:13 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"', > 'D [19/Sep/2012:05:26:57 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:26:57 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:26:57 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:26:57 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:26:57 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:26:57 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:26:57 -0400] Report: clients=1', > 'D [19/Sep/2012:05:26:57 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:26:57 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:26:57 -0400] Report: printers=2', > 'D [19/Sep/2012:05:26:57 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:26:57 -0400] Report: stringpool-string-count=24037', > 'D [19/Sep/2012:05:26:57 -0400] Report: stringpool-alloc-bytes=15064', > 'D [19/Sep/2012:05:26:57 -0400] Report: stringpool-total-bytes=448192', > 'D [19/Sep/2012:05:27:11 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:27:11 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:27:11 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:27:11 -0400] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [19/Sep/2012:05:27:11 -0400] Get-Notifications /', > 'D [19/Sep/2012:05:27:11 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:27:11 -0400] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [19/Sep/2012:05:27:11 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"', > 'D [19/Sep/2012:05:28:00 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:28:00 -0400] cupsdNetIFUpdate: "p1p1" = 169.254.78.143:631', > 'D [19/Sep/2012:05:28:00 -0400] cupsdNetIFUpdate: "em1" = 192.168.2.2:631', > 'D [19/Sep/2012:05:28:00 -0400] cupsdNetIFUpdate: "lo" = localhost:631', > 'D [19/Sep/2012:05:28:00 -0400] cupsdNetIFUpdate: "p1p1" = [v1.fe80::250:22ff:fe39:1596+p1p1]:631', > 'D [19/Sep/2012:05:28:00 -0400] cupsdNetIFUpdate: "em1" = [v1.fe80::4a5b:39ff:fe17:4ee+em1]:631', > 'D [19/Sep/2012:05:28:00 -0400] Report: clients=1', > 'D [19/Sep/2012:05:28:00 -0400] Report: jobs=17', > 'D [19/Sep/2012:05:28:00 -0400] Report: jobs-active=1', > 'D [19/Sep/2012:05:28:00 -0400] Report: printers=2', > 'D [19/Sep/2012:05:28:00 -0400] Report: printers-implicit=0', > 'D [19/Sep/2012:05:28:00 -0400] Report: stringpool-string-count=24037', > 'D [19/Sep/2012:05:28:00 -0400] Report: stringpool-alloc-bytes=15064', > 'D [19/Sep/2012:05:28:00 -0400] Report: stringpool-total-bytes=448192', > 'D [19/Sep/2012:05:28:08 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:28:08 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:28:08 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:28:08 -0400] cupsdReadClient: 29 1.1 Get-Job-Attributes 1', > 'D [19/Sep/2012:05:28:08 -0400] Get-Job-Attributes ipp://localhost/jobs/32', > 'D [19/Sep/2012:05:28:08 -0400] [Job 32] Loading attributes...', > 'D [19/Sep/2012:05:28:08 -0400] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/32) from localhost', > 'D [19/Sep/2012:05:28:08 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"', > 'D [19/Sep/2012:05:28:08 -0400] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [19/Sep/2012:05:28:08 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"', > 'D [19/Sep/2012:05:28:08 -0400] cupsdAuthorize: No authentication data provided.', > 'D [19/Sep/2012:05:28:08 -0400] cupsdReadClient: 29 1.1 Cancel-Subscription 1', > 'D [19/Sep/2012:05:28:08 -0400] Cancel-Subscription /', > 'D [19/Sep/2012:05:28:08 -0400] cupsdIsAuthorized: requesting-user-name="bob"', > 'D [19/Sep/2012:05:28:08 -0400] cupsdMarkDirty(-----S)', > 'D [19/Sep/2012:05:28:08 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"', > 'D [19/Sep/2012:05:28:08 -0400] Returning IPP successful-ok for Cancel-Subscription (/) from localhost', > 'D [19/Sep/2012:05:28:08 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [19/Sep/2012:05:28:09 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:28:09 -0400] cupsdAcceptClient: 17 from localhost (Domain)', > 'D [19/Sep/2012:05:28:09 -0400] cupsdAcceptClient: skipping getpeercon()', > 'D [19/Sep/2012:05:28:09 -0400] cupsdAcceptClient: 18 from localhost (Domain)', > 'D [19/Sep/2012:05:28:15 -0400] cupsdReadClient: 18 GET /admin/log/error_log HTTP/1.1', > 'D [19/Sep/2012:05:28:15 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [19/Sep/2012:05:28:15 -0400] cupsdAuthorize: No authentication data provided.']} >Page 10 (Printer state reasons): >{'printer-state-message': u'/usr/lib/cups/filter/gstoraster failed', > 'printer-state-reasons': [u'none']} >Page 11 (Locale issues): >{'printer_page_size': u'Letter', > 'system_locale_lang': 'en_US', > 'user_locale_ctype': 'en_US', > 'user_locale_messages': 'en_US'}
<b>You cannot view the attachment while viewing its details because your browser does not support IFRAMEs. <a href="attachment.cgi?id=614299">View the attachment on a separate page</a>.</b>
View Attachment As Raw
Actions:
View
Attachments on
bug 857388
:
613807
|
614297
| 614299