Bug#795404: cups-backend-bjnp: stops printing after some lines
Package: cups-backend-bjnp
Version: 1.2-2
Severity: grave
Justification: renders package unusable
Dear Maintainer,
* What led up to the situation?
Yesterday I newly installed my Canon Pixma MG6650 - it worked. I successfully
printed some pages. Today, after having changed nothing, I tried it again.
* What exactly did you do (or not do) that was effective (or
ineffective)?
Clicked on "print" in LOWriter.
* What was the outcome of this action?
The printer started with the first lines of the document and then stopped. The
printer's display showed a printing process going on. The queue told me there
was no connection ("printer connected?"). I used the troubleshooting dialogue
(protocol attached).
* What outcome did you expect instead?
That the printer makes it to the end of the page.
-- System Information:
Debian Release: 8.1
APT prefers stable-updates
APT policy: (500, 'stable-updates'), (500, 'stable')
Architecture: amd64 (x86_64)
Foreign Architectures: i386
Kernel: Linux 3.16.0-4-amd64 (SMP w/4 CPU cores)
Locale: LANG=de_DE.utf8, LC_CTYPE=de_DE.utf8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Init: systemd (via /run/systemd/system)
Versions of packages cups-backend-bjnp depends on:
ii libc6 2.19-18
ii libcups2 1.7.5-11+deb8u1
Versions of packages cups-backend-bjnp recommends:
pn foomatic-db-gutenprint <none>
cups-backend-bjnp suggests no packages.
-- no debconf information
Page 1 (Scheduler not running?):
{'cups_connection_failure': False}
Page 2 (Is local server publishing?):
{'local_server_exporting_printers': False}
Page 3 (Choose printer):
{'cups_dest': <cups.Dest Canon-MG6650 (default)>,
'cups_instance': None,
'cups_queue': u'Canon-MG6650',
'cups_queue_listed': True}
Page 4 (Check printer sanity):
{'cups_device_uri_scheme': u'bjnp',
'cups_printer_dict': {'device-uri': u'bjnp://db-printer.fritz.box:8611',
'printer-info': u'Canon MG6600 series',
'printer-is-shared': True,
'printer-location': u'',
'printer-make-and-model': u'Canon MG6600 series Ver.5.00',
'printer-state': 4,
'printer-state-message': u"Network host 'db-printer.fritz.box' is busy; will retry in 15 seconds...",
'printer-state-reasons': [u'connecting-to-device'],
'printer-type': 8556572,
'printer-uri-supported': u'ipp://localhost:631/printers/Canon-MG6650'},
'cups_printer_remote': False,
'is_cups_class': False,
'local_cups_queue_attributes': {'charset-configured': u'utf-8',
'charset-supported': [u'us-ascii', u'utf-8'],
'color-supported': False,
'compression-supported': [u'none', u'gzip'],
'copies-default': 1,
'copies-supported': (1, 9999),
'cups-version': u'1.7.5',
'device-uri': u'bjnp://db-printer.fritz.box:8611',
'document-format-default': u'application/octet-stream',
'document-format-supported': [u'application/octet-stream',
u'application/pdf',
u'application/postscript',
u'application/vnd.adobe-reader-postscript',
u'application/vnd.cups-command',
u'application/vnd.cups-pdf',
u'application/vnd.cups-pdf-banner',
u'application/vnd.cups-postscript',
u'application/vnd.cups-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/pwg-raster',
u'image/tiff',
u'image/urf',
u'image/x-bitmap',
u'image/x-photocd',
u'image/x-portable-anymap',
u'image/x-portable-bitmap',
u'image/x-portable-graymap',
u'image/x-portable-pixmap',
u'image/x-sgi-rgb',
u'image/x-sun-raster',
u'image/x-xbitmap',
u'image/x-xpixmap',
u'image/x-xwindowdump',
u'text/css',
u'text/html',
u'text/plain'],
'finishings-default': 3,
'finishings-supported': [3],
'generated-natural-language-supported': [u'de-de'],
'ipp-versions-supported': [u'1.0',
u'1.1',
u'2.0',
u'2.1'],
'ippget-event-life': 15,
'job-creation-attributes-supported': [u'copies',
u'finishings',
u'ipp-attribute-fidelity',
u'job-hold-until',
u'job-name',
u'job-priority',
u'job-sheets',
u'media',
u'media-col',
u'multiple-document-handling',
u'number-up',
u'output-bin',
u'orientation-requested',
u'page-ranges',
u'print-color-mode',
u'print-quality',
u'printer-resolution',
u'sides'],
'job-hold-until-default': u'no-hold',
'job-hold-until-supported': [u'no-hold',
u'indefinite',
u'day-time',
u'evening',
u'night',
u'second-shift',
u'third-shift',
u'weekend'],
'job-ids-supported': False,
'job-k-limit': 0,
'job-k-octets-supported': (0, 19092180),
'job-page-limit': 0,
'job-priority-default': 50,
'job-priority-supported': [100],
'job-quota-period': 0,
'job-settable-attributes-supported': [u'copies',
u'finishings',
u'job-hold-until',
u'job-name',
u'job-priority',
u'media',
u'media-col',
u'multiple-document-handling',
u'number-up',
u'output-bin',
u'orientation-requested',
u'page-ranges',
u'print-color-mode',
u'print-quality',
u'printer-resolution',
u'sides'],
'job-sheets-default': (u'none', u'none'),
'job-sheets-supported': [u'none',
u'classified',
u'confidential',
u'form',
u'secret',
u'standard',
u'topsecret',
u'unclassified'],
'jpeg-k-octets-supported': (0, 19092180),
'jpeg-x-dimension-supported': (0, 65535),
'jpeg-y-dimension-supported': (1, 65535),
'marker-change-time': 0,
'media-bottom-margin-supported': [500,
493,
507,
521,
0,
517,
3742,
3755],
'media-col-default': '(unknown IPP value tag 0x34)',
'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'iso_a4_210x297mm',
'media-left-margin-supported': [640,
340,
0,
560],
'media-right-margin-supported': [630,
358,
330,
346,
35,
326,
562,
570],
'media-size-supported': ['(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)',
'(unknown IPP value tag 0x34)'],
'media-supported': [u'na_letter_8.5x11in',
u'oe_legal_8.5x14in',
u'iso_a5_148x210mm',
u'iso_a4_210x297mm',
u'jis_b5_182x257mm',
u'oe_4x6in_4x6in',
u'oe_5x7in_5x7in',
u'oe_8x10in_8x10in',
u'oe_l-bl_3.5x5in',
u'jpn_hagaki_100x148mm',
u'om_envelop-10p_104.78x241.3mm',
u'om_envelopdlp_110.07x220.13mm',
u'custom_min_0x0in',
u'custom_max_0x0in'],
'media-top-margin-supported': [300, 35, 800],
'media-type-supported': [u'stationery',
u'photographic-glossy',
u'proplatinum',
u'luster',
u'semigloss',
u'photographic-glossy',
u'photographic-matte',
u'photopaper',
u'envelope',
u'ijpostcard',
u'postcard',
u'highres',
u'photo'],
'multiple-document-handling-supported': [u'separate-documents-uncollated-copies',
u'separate-documents-collated-copies'],
'multiple-document-jobs-supported': False,
'multiple-operation-time-out': 300,
'natural-language-configured': u'de-de',
'notify-attributes-supported': [u'printer-state-change-time',
u'notify-lease-expiration-time',
u'notify-subscriber-user-name'],
'notify-events-default': [u'job-completed'],
'notify-events-supported': [u'job-completed',
u'job-config-changed',
u'job-created',
u'job-progress',
u'job-state-changed',
u'job-stopped',
u'printer-added',
u'printer-changed',
u'printer-config-changed',
u'printer-deleted',
u'printer-finishings-changed',
u'printer-media-changed',
u'printer-modified',
u'printer-restarted',
u'printer-shutdown',
u'printer-state-changed',
u'printer-stopped',
u'server-audit',
u'server-restarted',
u'server-started',
u'server-stopped'],
'notify-lease-duration-default': 86400,
'notify-lease-duration-supported': (0,
2147483647),
'notify-max-events-supported': [100],
'notify-pull-method-supported': [u'ippget'],
'notify-schemes-supported': [u'dbus',
u'mailto',
u'rss'],
'number-up-default': 1,
'number-up-supported': [1, 2, 4, 6, 9, 16],
'operations-supported': [2,
4,
5,
6,
8,
9,
10,
11,
12,
13,
14,
16,
17,
18,
19,
20,
21,
22,
23,
24,
25,
26,
27,
28,
34,
35,
37,
38,
56,
57,
59,
16385,
16386,
16387,
16388,
16389,
16390,
16391,
16392,
16393,
16394,
16395,
16396,
16397,
16398,
16399,
16423,
14],
'orientation-requested-default': None,
'orientation-requested-supported': [3,
4,
5,
6],
'output-bin-default': u'face-down',
'output-bin-supported': [u'face-down'],
'page-ranges-supported': False,
'pages-per-minute': 1,
'pages-per-minute-color': 1,
'pdf-k-octets-supported': (0, 19092180),
'pdf-versions-supported': [u'adobe-1.2',
u'adobe-1.3',
u'adobe-1.4',
u'adobe-1.5',
u'adobe-1.6',
u'adobe-1.7',
u'iso-19005-1_2005',
u'iso-32000-1_2008',
u'pwg-5102.3'],
'pdl-override-supported': [u'attempted'],
'port-monitor': u'none',
'port-monitor-supported': [u'none'],
'print-color-mode-default': u'color',
'print-color-mode-supported': [u'monochrome',
u'color'],
'print-quality-default': 4,
'print-quality-supported': [4],
'printer-commands': [u'AutoConfigure',
u'Clean',
u'PrintSelfTestPage'],
'printer-current-time': '(IPP_TAG_DATE)',
'printer-dns-sd-name': u'Canon MG6600 series @ bs-ultrabook',
'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/Canon-MG6650.png',
'printer-info': u'Canon MG6600 series',
'printer-is-accepting-jobs': False,
'printer-is-shared': False,
'printer-location': u'',
'printer-make-and-model': u'Canon MG6600 series Ver.5.00',
'printer-more-info': u'http://localhost:631/printers/Canon-MG6650',
'printer-name': u'Canon-MG6650',
'printer-op-policy': u'default',
'printer-op-policy-supported': [u'authenticated',
u'default'],
'printer-resolution-default': (600, 600, 3),
'printer-resolution-supported': [(600,
600,
3)],
'printer-settable-attributes-supported': [u'printer-info',
u'printer-location'],
'printer-state': 4,
'printer-state-change-time': 1439487010,
'printer-state-message': u"Network host 'db-printer.fritz.box' is busy; will retry in 15 seconds...",
'printer-state-reasons': [u'connecting-to-device'],
'printer-type': 8556572,
'printer-up-time': 1439487029,
'printer-uri-supported': [u'ipp://localhost:631/printers/Canon-MG6650'],
'printer-uuid': u'urn:uuid:ee725734-118c-3c13-6c1b-7f2c9ee77fd8',
'pwg-raster-document-resolution-supported': [(600,
600,
3)],
'pwg-raster-document-sheet-back': u'normal',
'pwg-raster-document-type-supported': [u'adobergb-8',
u'adobergb-16',
u'black-1',
u'black-8',
u'black-16',
u'cmyk-8',
u'cmyk-16',
u'rgb-8',
u'rgb-16',
u'sgray-1',
u'sgray-8',
u'sgray-16',
u'srgb-8',
u'srgb-16'],
'queued-job-count': 1,
'server-is-sharing-printers': False,
'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 5 (Check PPD sanity):
{'cups_printer_ppd_defaults': {u'*CNGeneral': {u'ColorModel': u'rgb',
u'Resolution': u'600dpi'},
u'*CNMain': {u'CNGrayscale': u'False',
u'MediaType': u'plain'},
u'*CNPagesetup': {u'Duplex': u'None',
u'PageRegion': u'A4',
u'PageSize': u'A4'}},
'cups_printer_ppd_valid': True,
'missing_pkgs_and_exes': ([], [])}
Page 6 (Local or remote?):
{'printer_is_remote': False}
Page 7 (Choose device):
{'cups_device_dict': {'device-class': 'network',
'device-id': 'MFG:Canon;CMD:BJL,BJRaster3,BSCCe,NCCe,IVEC,IVECPLI;SOJ:BJNP2,BJNPe;MDL:MG6600 series;CLS:PRINTER;DES:Canon MG6600 series;VER:3.010;STA:10;FSI:00;HRI:D;MSI:AOFF,B015,DAT,E3,HFSF,JOFF,K21000700,LOFF;PDR:4;PSE:ADMM96370;CID:CA_IVEC1TYPE4_IJP;',
'device-info': 'Canon MG6600 series db-printer.fritz.box',
'device-make-and-model': 'Canon MG6600 series'}}
Page 8 (Printer state reasons):
{'printer-state-message': u"Network host 'db-printer.fritz.box' is busy; will retry in 15 seconds...",
'printer-state-reasons': [u'connecting-to-device']}
Page 9 (Error log checkpoint):
{'cups_server_settings': {'BrowseLocalProtocols': 'dnssd',
'DefaultAuthType': 'Basic',
'JobPrivateAccess': 'default',
'JobPrivateValues': 'default',
'MaxLogSize': '0',
'SubscriptionPrivateAccess': 'default',
'SubscriptionPrivateValues': 'default',
'WebInterface': 'Yes',
'_debug_logging': '0',
'_remote_admin': '0',
'_remote_any': '0',
'_share_printers': '1',
'_user_cancel_any': '0'},
'error_log_checkpoint': 47031,
'error_log_debug_logging_set': True}
Page 10 (Error log fetch):
{'error_log': ['D [13/Aug/2015:19:30:49 +0200] [Client 17] Sending file.',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=47031, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=44983, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=42935, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=40887, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=38839, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=36791, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=34743, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=32695, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=30647, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=28599, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=26551, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=24503, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=22455, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=20407, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=18359, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=16311, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=14263, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=12215, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=10167, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=8119, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6071, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=4023, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1975, response=(nil)(), pipe_pid=0, file=19',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] Waiting for request.',
'D [13/Aug/2015:19:30:49 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] POST / HTTP/1.1',
'D [13/Aug/2015:19:30:49 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] No authentication data provided.',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] 2.0 Get-Jobs 226',
'D [13/Aug/2015:19:30:49 +0200] Get-Jobs ipp://localhost/printers/',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] Content-Length: 170',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=170, response=0x7f645ea379a0(IPP_IDLE), pipe_pid=0, file=-1',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] bytes=0, http_state=0, data_remaining=0',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] Waiting for request.',
'D [13/Aug/2015:19:30:49 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] POST / HTTP/1.1',
'D [13/Aug/2015:19:30:49 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] No authentication data provided.',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] 2.0 Get-Jobs 227',
'D [13/Aug/2015:19:30:49 +0200] Get-Jobs ipp://localhost/printers/',
'D [13/Aug/2015:19:30:49 +0200] [Job 11] Loading attributes...',
'D [13/Aug/2015:19:30:49 +0200] [Job 10] Loading attributes...',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] Content-Length: 265',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=265, response=0x7f645ea57200(IPP_IDLE), pipe_pid=0, file=-1',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] bytes=0, http_state=0, data_remaining=0',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] Waiting for request.',
'D [13/Aug/2015:19:30:49 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] PUT /admin/conf/cupsd.conf HTTP/1.1',
'D [13/Aug/2015:19:30:49 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] Authorized as root using PeerCred',
'D [13/Aug/2015:19:30:49 +0200] cupsdIsAuthorized: username="root"',
'D [13/Aug/2015:19:30:49 +0200] cupsd is not idle any more, canceling shutdown.',
'I [13/Aug/2015:19:30:49 +0200] Installing config file "/etc/cups/cupsd.conf"...',
'D [13/Aug/2015:19:30:49 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"',
'D [13/Aug/2015:19:30:49 +0200] [Client 17] Closing connection.',
'D [13/Aug/2015:19:30:49 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
'D [13/Aug/2015:19:30:49 +0200] [Client 18] Closing connection.',
'D [13/Aug/2015:19:30:49 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"',
'I [13/Aug/2015:19:30:49 +0200] Generating printcap /var/run/cups/printcap...',
'D [13/Aug/2015:19:30:49 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"',
'E [13/Aug/2015:19:30:49 +0200] Unknown directive JobPrivateAccess on line 84 of /etc/cups/cupsd.conf.',
'E [13/Aug/2015:19:30:49 +0200] Unknown directive JobPrivateValues on line 85 of /etc/cups/cupsd.conf.',
'E [13/Aug/2015:19:30:49 +0200] Unknown directive SubscriptionPrivateAccess on line 86 of /etc/cups/cupsd.conf.',
'E [13/Aug/2015:19:30:49 +0200] Unknown directive SubscriptionPrivateValues on line 87 of /etc/cups/cupsd.conf.',
"W [13/Aug/2015:19:30:49 +0200] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-MG6650-Gray..' already exists",
"W [13/Aug/2015:19:30:49 +0200] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-MG6650-RGB..' already exists"],
'error_log_debug_logging_unset': True}
Page 11 (Printer state reasons):
{'printer-state-message': u"Network host 'db-printer.fritz.box' is busy; will retry in 20 seconds...",
'printer-state-reasons': [u'connecting-to-device']}
Page 12 (Locale issues):
{'printer_page_size': u'A4',
'system_locale_lang': None,
'user_locale_ctype': 'de_DE',
'user_locale_messages': 'de_DE'}
Reply to: