[opensuse] cups 1.7.5 no printing of text/plain files on lexmark postscript printer possible
Hello, I hope a cups expert is here. Maybe the problem is upstream... I never had problems with cups and postscript-capable printers until upgrade to Leap 42.2 and cups 1.7.5 with my Lexmark E360d printer. Printing of PDF files and printing e.g. from LibreOffice works. Self-Test Page leads to only a box and "Lexmark E360d 3011.010 20081117 318480588" printed in. When trying to print plain text, printer claims: "ERROR: ioerror OFFENDING COMMAND: StartData STACK: 0 ( cryptic signs ) arraytype" maybe it's just a missing font (shouldn't exotic font data be included?).. no Idea how to check/correct thanks for any hint I also looked into the data actually sent to the printer (hex trace printout): it starts with PJL data, and then postscript, but I see very often some the keyword pdf in it.. Data (captured from ipp stream, being sent from network print server 1:1 to printer via parallel port) at the end of mail.. unfortunately i have no such data from previous cups versions, nor somewhere installed. Worst, no older cups version available for Leap 42.2 :( all cups packages installed are from openSuSE Main oss repository: (i actually did create even a new /etc/cups directory, parts of old config was still from SuSE 6.4 iirc) # rpm -qav | grep cups liboyranos0-cups-0.9.5-1.6.x86_64 libgnomecups-lang-0.2.3-141.3.noarch cups-filters-ghostscript-1.8.2-1.5.x86_64 cups-filters-foomatic-rip-1.8.2-1.5.x86_64 cups-libs-32bit-1.7.5-7.10.x86_64 cups-1.7.5-7.10.x86_64 python3-cupshelpers-1.5.7-7.1.noarch cups-backends-1.1-7.1.noarch cups-client-1.7.5-7.10.x86_64 cups-libs-1.7.5-7.10.x86_64 cups-filters-1.8.2-1.5.x86_64 cups-filters-cups-browsed-1.8.2-1.5.x86_64 python-cups-1.9.72-3.2.x86_64 monitoring-plugins-cups-2.2-29.1.x86_64 python3-cups-1.9.72-4.2.x86_64 cups-pk-helper-lang-0.2.5-6.4.noarch cups-pk-helper-0.2.5-6.4.x86_64 libgnomecups-0.2.3-141.3.x86_64 /etc/cups/printers.conf <DefaultPrinter E360d> UUID urn:uuid:e65febf1-6c2d-37ec-515f-8223cbcaa78c AuthInfoRequired none Info Lexmark E360d Foomatic/Postscript DeviceURI ipp://printserver1.swabian.net/LPT2 State Idle StateTime 1485446941 Type 8433692 Accepting Yes Shared Yes JobSheets none none QuotaPeriod 0 PageLimit 0 KLimit 0 OpPolicy default ErrorPolicy stop-printer </Printer> other config files are original, only changed to allow remote access. from /var/log/cups/error.log: I [26/Jan/2017:11:24:15 +0100] Saving printers.conf... I [26/Jan/2017:11:24:15 +0100] Saving job.cache... D [26/Jan/2017:11:24:15 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Printing jobs and dirty files" I [26/Jan/2017:11:24:16 +0100] Scheduler shutting down normally. D [26/Jan/2017:11:24:16 +0100] Discarding unused server-stopped event... I [26/Jan/2017:11:24:16 +0100] Saving job.cache... D [26/Jan/2017:11:24:16 +0100] cupsdStopSelect() I [26/Jan/2017:11:24:16 +0100] Listening to 172.18.0.1:631 (IPv4) I [26/Jan/2017:11:24:16 +0100] Listening to 172.17.0.1:631 (IPv4) I [26/Jan/2017:11:24:16 +0100] Listening to [v1.::1]:631 (IPv6) I [26/Jan/2017:11:24:16 +0100] Listening to 127.0.0.1:631 (IPv4) I [26/Jan/2017:11:24:16 +0100] Listening to /run/cups/cups.sock (Domain) I [26/Jan/2017:11:24:16 +0100] Remote access is enabled. D [26/Jan/2017:11:24:16 +0100] Added auto ServerAlias alpha D [26/Jan/2017:11:24:16 +0100] Added auto ServerAlias alpha.swabian.net I [26/Jan/2017:11:24:16 +0100] Loaded configuration file "/etc/cups/cupsd.conf" D [26/Jan/2017:11:24:16 +0100] Repairing access permissions of "/etc/cups/classes.conf" I [26/Jan/2017:11:24:16 +0100] Using default TempDir of /var/spool/cups/tmp... I [26/Jan/2017:11:24:16 +0100] Configured for up to 100 clients. I [26/Jan/2017:11:24:16 +0100] Allowing up to 100 client connections per host. I [26/Jan/2017:11:24:16 +0100] Full reload is required. I [26/Jan/2017:11:24:16 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 44 types, 79 filters... D [26/Jan/2017:11:24:16 +0100] Loading printer E360d... D [26/Jan/2017:11:24:16 +0100] load_ppd: Loading /var/cache/cups/E360d.data... D [26/Jan/2017:11:24:16 +0100] cupsdRegisterPrinter(p=0x557750f23ed0(E360d)) I [26/Jan/2017:11:24:16 +0100] Loading job cache file "/var/cache/cups/job.cache"... D [26/Jan/2017:11:24:16 +0100] [Job 715] Loading from cache... [... D [26/Jan/2017:11:24:16 +0100] [Job 1214] Loading from cache... D [26/Jan/2017:11:24:16 +0100] [Job 715] Removing from history. I [26/Jan/2017:11:24:16 +0100] Full reload complete. D [26/Jan/2017:11:24:16 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)") I [26/Jan/2017:11:24:16 +0100] Cleaning out old files in "/var/spool/cups/tmp". D [26/Jan/2017:11:24:16 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp/.cache", pattern="(null)") I [26/Jan/2017:11:24:16 +0100] Cleaning out old files in "/var/spool/cups/tmp/.cache". D [26/Jan/2017:11:24:16 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp/.cache/fontconfig", pattern="(null)") I [26/Jan/2017:11:24:16 +0100] Cleaning out old files in "/var/spool/cups/tmp/.cache/fontconfig". D [26/Jan/2017:11:24:16 +0100] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp") I [26/Jan/2017:11:24:16 +0100] Cleaning out old files in "/var/cache/cups". D [26/Jan/2017:11:24:16 +0100] Calling FindDeviceById(cups-E360d) D [26/Jan/2017:11:24:16 +0100] FindDeviceById failed: org.freedesktop.ColorManager.NotFound:device id 'cups-E360d' does not exist D [26/Jan/2017:11:24:16 +0100] Using profile ID "E360d-Gray..". D [26/Jan/2017:11:24:16 +0100] Calling CreateProfile(E360d-Gray..,temp) D [26/Jan/2017:11:24:16 +0100] Created profile "/org/freedesktop/ColorManager/profiles/E360d_Gray__". D [26/Jan/2017:11:24:16 +0100] Using profile ID "E360d-RGB..". D [26/Jan/2017:11:24:16 +0100] Calling CreateProfile(E360d-RGB..,temp) D [26/Jan/2017:11:24:16 +0100] Created profile "/org/freedesktop/ColorManager/profiles/E360d_RGB__". I [26/Jan/2017:11:24:16 +0100] Registering ICC color profiles for "E360d". D [26/Jan/2017:11:24:16 +0100] Calling CreateDevice(cups-E360d,temp) D [26/Jan/2017:11:24:16 +0100] Created device "/org/freedesktop/ColorManager/devices/cups_E360d". D [26/Jan/2017:11:24:16 +0100] Calling /org/freedesktop/ColorManager/devices/cups_E360d:AddProfile(/org/freedesktop/ColorManager/profiles/E360d_Gray__) [soft] D [26/Jan/2017:11:24:16 +0100] Calling /org/freedesktop/ColorManager/devices/cups_E360d:AddProfile(/org/freedesktop/ColorManager/profiles/E360d_RGB__) [soft] I [26/Jan/2017:11:24:16 +0100] Listening to 172.18.0.1:631 on fd 8... I [26/Jan/2017:11:24:16 +0100] Listening to 172.17.0.1:631 on fd 9... E [26/Jan/2017:11:24:16 +0100] Unable to bind socket for address [v1.::1]:631 - Cannot assign requested address. I [26/Jan/2017:11:24:16 +0100] Listening to 127.0.0.1:631 on fd 10... I [26/Jan/2017:11:24:16 +0100] Listening to /run/cups/cups.sock:631 on fd 11... I [26/Jan/2017:11:24:16 +0100] Resuming new connection processing... D [26/Jan/2017:11:24:16 +0100] Avahi server connection now available, registering printers for Bonjour broadcasting. D [26/Jan/2017:11:24:16 +0100] Registering "Lexmark E360d Foomatic/Postscript @ alpha" with DNS-SD type "_printer._tcp". D [26/Jan/2017:11:24:16 +0100] Registering "Lexmark E360d Foomatic/Postscript @ alpha" with DNS-SD type "_ipps._tcp". D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-type=0x80B01E D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-state=3 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Duplex=T D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Color=T D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" TLS=1.2 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" UUID=e65febf1-6c2d-37ec-515f-8223cbcaa78c D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" product=(Lexmark E360dn) D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" priority=0 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" adminurl=https://alpha.local:631/printers/E360d D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" ty=Unknown D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" rp=printers/E360d D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" qtotal=1 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" txtvers=1 D [26/Jan/2017:11:24:16 +0100] Registering "Lexmark E360d Foomatic/Postscript @ alpha" with DNS-SD type "_ipp._tcp". D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-type=0x80B01E D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-state=3 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Duplex=T D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Color=T D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" TLS=1.2 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" UUID=e65febf1-6c2d-37ec-515f-8223cbcaa78c D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" product=(Lexmark E360dn) D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" priority=0 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" adminurl=https://alpha.local:631/printers/E360d D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" ty=Unknown D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" rp=printers/E360d D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" qtotal=1 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" txtvers=1 D [26/Jan/2017:11:24:16 +0100] Registering "Lexmark E360d Foomatic/Postscript @ alpha" with DNS-SD type "_printer._tcp". D [26/Jan/2017:11:24:16 +0100] Registering "Lexmark E360d Foomatic/Postscript @ alpha" with DNS-SD type "_ipps._tcp". D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-type=0x80B01E D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-state=3 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Duplex=T D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Color=T D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" TLS=1.2 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" UUID=e65febf1-6c2d-37ec-515f-8223cbcaa78c D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" product=(Lexmark E360dn) D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" priority=0 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" adminurl=https://alpha.local:631/printers/E360d D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" ty=Unknown D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" rp=printers/E360d D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" qtotal=1 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" txtvers=1 D [26/Jan/2017:11:24:16 +0100] Registering "Lexmark E360d Foomatic/Postscript @ alpha" with DNS-SD type "_ipp._tcp". D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-type=0x80B01E D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-state=3 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Duplex=T D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Color=T D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" TLS=1.2 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" UUID=e65febf1-6c2d-37ec-515f-8223cbcaa78c D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" product=(Lexmark E360dn) D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" priority=0 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" adminurl=https://alpha.local:631/printers/E360d D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" ty=Unknown D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" rp=printers/E360d D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" qtotal=1 D [26/Jan/2017:11:24:16 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" txtvers=1 D [26/Jan/2017:11:24:16 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy" D [26/Jan/2017:11:24:16 +0100] Discarding unused server-started event... D [26/Jan/2017:11:24:17 +0100] Report: clients=0 D [26/Jan/2017:11:24:17 +0100] Report: jobs=499 D [26/Jan/2017:11:24:17 +0100] Report: jobs-active=0 D [26/Jan/2017:11:24:17 +0100] Report: printers=1 D [26/Jan/2017:11:24:17 +0100] Report: stringpool-string-count=1127 D [26/Jan/2017:11:24:17 +0100] Report: stringpool-alloc-bytes=6656 D [26/Jan/2017:11:24:17 +0100] Report: stringpool-total-bytes=20920 D [26/Jan/2017:11:24:19 +0100] [Client 17] Accepted from localhost (Domain) D [26/Jan/2017:11:24:19 +0100] [Client 17] Waiting for request. D [26/Jan/2017:11:24:19 +0100] [Client 17] POST / HTTP/1.1 D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" D [26/Jan/2017:11:24:19 +0100] [Client 17] No authentication data provided. D [26/Jan/2017:11:24:19 +0100] [Client 17] 2.0 CUPS-Get-Default 1 D [26/Jan/2017:11:24:19 +0100] CUPS-Get-Default D [26/Jan/2017:11:24:19 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost D [26/Jan/2017:11:24:19 +0100] [Client 17] Content-Length: 1116 D [26/Jan/2017:11:24:19 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1116, response=0x557750fbd340(IPP_IDLE), pipe_pid=0, file=-1 D [26/Jan/2017:11:24:19 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0 D [26/Jan/2017:11:24:19 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0 D [26/Jan/2017:11:24:19 +0100] [Client 17] Waiting for request. D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" D [26/Jan/2017:11:24:19 +0100] [Client 17] POST /printers/E360d HTTP/1.1 D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" D [26/Jan/2017:11:24:19 +0100] [Client 17] No authentication data provided. D [26/Jan/2017:11:24:19 +0100] [Client 17] 2.0 Create-Job 2 D [26/Jan/2017:11:24:19 +0100] Create-Job ipp://localhost:631/printers/E360d D [26/Jan/2017:11:24:19 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients" D [26/Jan/2017:11:24:19 +0100] add_job: requesting-user-name="root" I [26/Jan/2017:11:24:19 +0100] [Job 1215] Adding start banner page "none". D [26/Jan/2017:11:24:19 +0100] Discarding unused job-created event... I [26/Jan/2017:11:24:19 +0100] [Job 1215] Queued on "E360d" by "root". D [26/Jan/2017:11:24:19 +0100] [Client 17] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/E360d) from localhost D [26/Jan/2017:11:24:19 +0100] [Client 17] Content-Length: 184 D [26/Jan/2017:11:24:19 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=184, response=0x557750fbce70(IPP_IDLE), pipe_pid=0, file=-1 D [26/Jan/2017:11:24:19 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0 D [26/Jan/2017:11:24:19 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0 D [26/Jan/2017:11:24:19 +0100] [Client 17] Waiting for request. D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [26/Jan/2017:11:24:19 +0100] [Client 17] POST /printers/E360d HTTP/1.1 D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [26/Jan/2017:11:24:19 +0100] [Client 17] No authentication data provided. D [26/Jan/2017:11:24:19 +0100] [Client 17] 2.0 Send-Document 3 D [26/Jan/2017:11:24:19 +0100] Send-Document ipp://localhost:631/printers/E360d D [26/Jan/2017:11:24:19 +0100] cupsdIsAuthorized: requesting-user-name="root" D [26/Jan/2017:11:24:19 +0100] [Job 1215] Auto-typing file... D [26/Jan/2017:11:24:19 +0100] [Job 1215] Request file type is text/plain. D [26/Jan/2017:11:24:19 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" I [26/Jan/2017:11:24:19 +0100] [Job 1215] File of type text/plain queued by "root". I [26/Jan/2017:11:24:19 +0100] [Job 1215] Adding end banner page "none". D [26/Jan/2017:11:24:19 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [26/Jan/2017:11:24:19 +0100] [Job 1215] time-at-processing=1485426259 D [26/Jan/2017:11:24:19 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [26/Jan/2017:11:24:19 +0100] Discarding unused printer-state-changed event... D [26/Jan/2017:11:24:19 +0100] [Job 1215] 3 filters for job: D [26/Jan/2017:11:24:19 +0100] [Job 1215] texttopdf (text/plain to application/pdf, cost 32) D [26/Jan/2017:11:24:19 +0100] [Job 1215] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66) D [26/Jan/2017:11:24:19 +0100] [Job 1215] foomatic-rip (application/vnd.cups-pdf to printer/E360d, cost 0) D [26/Jan/2017:11:24:19 +0100] [Job 1215] job-sheets=none,none D [26/Jan/2017:11:24:19 +0100] [Job 1215] argv[0]="E360d" D [26/Jan/2017:11:24:19 +0100] [Job 1215] argv[1]="1215" D [26/Jan/2017:11:24:19 +0100] [Job 1215] argv[2]="root" D [26/Jan/2017:11:24:19 +0100] [Job 1215] argv[3]="(stdin)" D [26/Jan/2017:11:24:19 +0100] [Job 1215] argv[4]="1" D [26/Jan/2017:11:24:19 +0100] [Job 1215] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:3542e92d-aae6-34f7-5b1c-1ff7d9d7a9da job-originating-host-name=localhost time-at-creation=1485426259 time-at-processing=1485426259" D [26/Jan/2017:11:24:19 +0100] [Job 1215] argv[6]="/var/spool/cups/d01215-001" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[0]="CUPS_CACHEDIR=/var/cache/cups" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[1]="CUPS_DATADIR=/usr/share/cups" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[2]="CUPS_DOCROOT=/usr/share/cups/webcontent" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[6]="CUPS_SERVERROOT=/etc/cups" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[7]="CUPS_STATEDIR=/run/cups" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[8]="HOME=/var/spool/cups/tmp" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[10]="SERVER_ADMIN=root@alpha.swabian.net" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[11]="SOFTWARE=CUPS/1.7.5" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[12]="TMPDIR=/var/spool/cups/tmp" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[13]="USER=root" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[14]="CUPS_MAX_MESSAGE=2047" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[15]="CUPS_SERVER=/run/cups/cups.sock" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[16]="CUPS_ENCRYPTION=IfRequested" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[17]="IPP_PORT=631" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[18]="CHARSET=utf-8" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[19]="LANG=en_US.UTF-8" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[20]="PPD=/etc/cups/ppd/E360d.ppd" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[21]="RIP_MAX_CACHE=128m" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[22]="CONTENT_TYPE=text/plain" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[23]="DEVICE_URI=ipp://printserver1.swabian.net/LPT2" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[24]="PRINTER_INFO=Lexmark E360d Foomatic/Postscript" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[25]="PRINTER_LOCATION=" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[26]="PRINTER=E360d" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[27]="PRINTER_STATE_REASONS=none" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[28]="CUPS_FILETYPE=document" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-pdf" D [26/Jan/2017:11:24:19 +0100] [Job 1215] envp[30]="AUTH_I****" I [26/Jan/2017:11:24:19 +0100] [Job 1215] Started filter /usr/lib/cups/filter/texttopdf (PID 22942) I [26/Jan/2017:11:24:19 +0100] [Job 1215] Started filter /usr/lib/cups/filter/pdftopdf (PID 22943) I [26/Jan/2017:11:24:19 +0100] [Job 1215] Started filter /usr/lib/cups/filter/foomatic-rip (PID 22944) I [26/Jan/2017:11:24:19 +0100] [Job 1215] Started backend /usr/lib/cups/backend/ipp (PID 22945) D [26/Jan/2017:11:24:19 +0100] Discarding unused job-state-changed event... D [26/Jan/2017:11:24:19 +0100] [Client 17] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/E360d) from localhost D [26/Jan/2017:11:24:19 +0100] [Client 17] Content-Length: 176 D [26/Jan/2017:11:24:19 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=176, response=0x557750fba710(IPP_IDLE), pipe_pid=0, file=-1 D [26/Jan/2017:11:24:19 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0 D [26/Jan/2017:11:24:19 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0 D [26/Jan/2017:11:24:19 +0100] [Client 17] Waiting for request. D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files" D [26/Jan/2017:11:24:19 +0100] [Client 17] HTTP_STATE_WAITING Closing on EOF D [26/Jan/2017:11:24:19 +0100] [Client 17] Closing connection. D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [26/Jan/2017:11:24:19 +0100] [Job 1215] Sending stdin for job... D [26/Jan/2017:11:24:19 +0100] [Job 1215] update_reasons(attr=0(), s="+connecting-to-device") D [26/Jan/2017:11:24:19 +0100] [Job 1215] STATE: +connecting-to-device D [26/Jan/2017:11:24:19 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:19 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files" D [26/Jan/2017:11:24:19 +0100] [Job 1215] Looking up "printserver1.swabian.net"... D [26/Jan/2017:11:24:19 +0100] Discarding unused printer-state-changed event... D [26/Jan/2017:11:24:19 +0100] [Job 1215] backendWaitLoop(snmp_fd=5, addr=0x55fc40671938, side_cb=0x55fc402b2a00) D [26/Jan/2017:11:24:19 +0100] [Job 1215] Page = 595x842; 18,36 to 577,806 D [26/Jan/2017:11:24:19 +0100] [Job 1215] Calling FindDeviceById(cups-E360d) D [26/Jan/2017:11:24:19 +0100] [Job 1215] Found device /org/freedesktop/ColorManager/devices/cups_E360d D [26/Jan/2017:11:24:19 +0100] [Job 1215] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors) D [26/Jan/2017:11:24:19 +0100] [Job 1215] 'CM Color Calibration' Mode in SPOOLER-LESS: Off D [26/Jan/2017:11:24:19 +0100] [Job 1215] Getting input from file D [26/Jan/2017:11:24:19 +0100] [Job 1215] foomatic-rip version 1.8.2 running... D [26/Jan/2017:11:24:19 +0100] [Job 1215] Parsing PPD file ... D [26/Jan/2017:11:24:19 +0100] [Job 1215] Added option ColorSpace D [26/Jan/2017:11:24:19 +0100] [Job 1215] Added option PageSize D [26/Jan/2017:11:24:19 +0100] [Job 1215] CUPS page accounting disabled by driver. D [26/Jan/2017:11:24:19 +0100] [Job 1215] Added option ImageableArea D [26/Jan/2017:11:24:19 +0100] [Job 1215] Added option PaperDimension D [26/Jan/2017:11:24:19 +0100] [Job 1215] Added option InputSlot D [26/Jan/2017:11:24:19 +0100] [Job 1215] Added option Duplex D [26/Jan/2017:11:24:19 +0100] [Job 1215] Added option Resolution D [26/Jan/2017:11:24:19 +0100] [Job 1215] Added option Font D [26/Jan/2017:11:24:19 +0100] [Job 1215] Parameter Summary D [26/Jan/2017:11:24:19 +0100] [Job 1215] ----------------- D [26/Jan/2017:11:24:19 +0100] [Job 1215] Spooler: cups D [26/Jan/2017:11:24:19 +0100] [Job 1215] Printer: E360d D [26/Jan/2017:11:24:19 +0100] [Job 1215] Shell: /bin/bash D [26/Jan/2017:11:24:19 +0100] [Job 1215] PPD file: /etc/cups/ppd/E360d.ppd D [26/Jan/2017:11:24:19 +0100] [Job 1215] ATTR file: D [26/Jan/2017:11:24:19 +0100] [Job 1215] Printer model: Lexmark E360d Foomatic/Postscript D [26/Jan/2017:11:24:19 +0100] [Job 1215] Job title: stdin D [26/Jan/2017:11:24:19 +0100] [Job 1215] File(s) to be printed: D [26/Jan/2017:11:24:19 +0100] [Job 1215] <STDIN> D [26/Jan/2017:11:24:19 +0100] [Job 1215] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts D [26/Jan/2017:11:24:19 +0100] [Job 1215] Printing system options: D [26/Jan/2017:11:24:19 +0100] [Job 1215] Pondering option 'finishings=3' D [26/Jan/2017:11:24:19 +0100] [Job 1215] Unknown option finishings=3. D [26/Jan/2017:11:24:19 +0100] [Job 1215] Pondering option 'number-up=1' D [26/Jan/2017:11:24:19 +0100] [Job 1215] Unknown option number-up=1. D [26/Jan/2017:11:24:19 +0100] [Job 1215] Pondering option 'job-uuid=urn:uuid:3542e92d-aae6-34f7-5b1c-1ff7d9d7a9da' D [26/Jan/2017:11:24:19 +0100] [Job 1215] Unknown option job-uuid=urn:uuid:3542e92d-aae6-34f7-5b1c-1ff7d9d7a9da. D [26/Jan/2017:11:24:19 +0100] [Job 1215] Pondering option 'job-originating-host-name=localhost' D [26/Jan/2017:11:24:19 +0100] [Job 1215] Unknown option job-originating-host-name=localhost. D [26/Jan/2017:11:24:19 +0100] [Job 1215] Pondering option 'time-at-creation=1485426259' D [26/Jan/2017:11:24:19 +0100] [Job 1215] Unknown option time-at-creation=1485426259. D [26/Jan/2017:11:24:19 +0100] [Job 1215] Pondering option 'time-at-processing=1485426259' D [26/Jan/2017:11:24:19 +0100] [Job 1215] Unknown option time-at-processing=1485426259. D [26/Jan/2017:11:24:19 +0100] [Job 1215] CM Color Calibration Mode in CUPS: Off D [26/Jan/2017:11:24:19 +0100] [Job 1215] Options from the PPD file: D [26/Jan/2017:11:24:19 +0100] [Job 1215] ================================================ D [26/Jan/2017:11:24:19 +0100] [Job 1215] File: <STDIN> D [26/Jan/2017:11:24:19 +0100] [Job 1215] ================================================ D [26/Jan/2017:11:24:21 +0100] [Job 1215] PID 22942 (/usr/lib/cups/filter/texttopdf) exited with no errors. D [26/Jan/2017:11:24:21 +0100] [Job 1215] Filetype: PDF D [26/Jan/2017:11:24:21 +0100] [Job 1215] PostScript option found: PageSize=Letter: "<</PageSize[612 792]/ImagingBBox null>>setpagedevice" D [26/Jan/2017:11:24:21 +0100] [Job 1215] Driver does not understand PDF input, converting to PostScript D [26/Jan/2017:11:24:21 +0100] [Job 1215] Storing temporary files in /var/spool/cups/tmp D [26/Jan/2017:11:24:21 +0100] [Job 1215] PID 22943 (/usr/lib/cups/filter/pdftopdf) exited with no errors. D [26/Jan/2017:11:24:21 +0100] [Job 1215] Starting process "pdf-to-ps" (generation 1) D [26/Jan/2017:11:24:21 +0100] [Job 1215] Printer make and model: Lexmark Lexmark E360dn D [26/Jan/2017:11:24:21 +0100] [Job 1215] Running command line for pstops: pstops 1215 root stdin 1 ' finishings=3 job-uuid=urn:uuid:3542e92d-aae6-34f7-5b1c-1ff7d9d7a9da job-originating-host-name=localhost time-at-creation=1485426259 time-at-processing=1485426259' D [26/Jan/2017:11:24:21 +0100] [Job 1215] Using image rendering resolution 600 dpi D [26/Jan/2017:11:24:21 +0100] [Job 1215] Running command line for pdftops: pdftops -level3 -origpagesizes -nocenter -r 600 /var/spool/cups/tmp/foomatic-fOwfSD - D [26/Jan/2017:11:24:21 +0100] [Job 1215] Started filter pdftops (PID 22948) D [26/Jan/2017:11:24:21 +0100] [Job 1215] Started filter pstops (PID 22949) D [26/Jan/2017:11:24:21 +0100] [Job 1215] Page = 595x842; 18,36 to 577,806 D [26/Jan/2017:11:24:21 +0100] [Job 1215] slow_collate=0, slow_duplex=0, slow_order=0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] Before copy_comments - %!PS-Adobe-3.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] %!PS-Adobe-3.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] %Produced by poppler pdftops version: 0.43.0 (http://poppler.freedesktop.org) D [26/Jan/2017:11:24:21 +0100] [Job 1215] %%Creator: texttopdf/1.8.2 D [26/Jan/2017:11:24:21 +0100] [Job 1215] %%LanguageLevel: 3 D [26/Jan/2017:11:24:21 +0100] [Job 1215] %%DocumentSuppliedResources: (atend) D [26/Jan/2017:11:24:21 +0100] [Job 1215] %%DocumentMedia: A4 595 842 0 () () D [26/Jan/2017:11:24:21 +0100] [Job 1215] %%BoundingBox: 0 0 595 842 D [26/Jan/2017:11:24:21 +0100] [Job 1215] %%Pages: 4 D [26/Jan/2017:11:24:21 +0100] [Job 1215] %%EndComments D [26/Jan/2017:11:24:21 +0100] [Job 1215] Before copy_prolog - %%BeginProlog D [26/Jan/2017:11:24:21 +0100] [Job 1215] Filetype: PostScript D [26/Jan/2017:11:24:21 +0100] [Job 1215] Reading PostScript input ... D [26/Jan/2017:11:24:21 +0100] [Job 1215] --> This document is DSC-conforming! D [26/Jan/2017:11:24:21 +0100] [Job 1215] Found %RBINumCopies: 1 D [26/Jan/2017:11:24:21 +0100] [Job 1215] ----------- D [26/Jan/2017:11:24:21 +0100] [Job 1215] Found: %%BeginProlog D [26/Jan/2017:11:24:21 +0100] [Job 1215] Inserting option code into "Prolog" section. D [26/Jan/2017:11:24:21 +0100] [Job 1215] Before copy_setup - %%BeginSetup D [26/Jan/2017:11:24:21 +0100] [Job 1215] Found: %%EndProlog D [26/Jan/2017:11:24:21 +0100] [Job 1215] ----------- D [26/Jan/2017:11:24:21 +0100] [Job 1215] Found: %%BeginSetup D [26/Jan/2017:11:24:21 +0100] [Job 1215] Found: %%BeginFeature: *Resolution 600x600dpi D [26/Jan/2017:11:24:21 +0100] [Job 1215] Option: Resolution=600x600dpi D [26/Jan/2017:11:24:21 +0100] [Job 1215] --> Option will be set by PostScript interpreter D [26/Jan/2017:11:24:21 +0100] [Job 1215] Found: %%BeginFeature: *PageSize A4 D [26/Jan/2017:11:24:21 +0100] [Job 1215] Option: PageSize=A4 D [26/Jan/2017:11:24:21 +0100] [Job 1215] --> Option will be set by PostScript interpreter D [26/Jan/2017:11:24:21 +0100] [Job 1215] Found: %%BeginFeature: *InputSlot Multipurpose D [26/Jan/2017:11:24:21 +0100] [Job 1215] Option: InputSlot=Multipurpose D [26/Jan/2017:11:24:21 +0100] [Job 1215] --> Option will be set by PostScript interpreter D [26/Jan/2017:11:24:21 +0100] [Job 1215] Found: %%BeginFeature: *Duplex None D [26/Jan/2017:11:24:21 +0100] [Job 1215] Option: Duplex=None D [26/Jan/2017:11:24:21 +0100] [Job 1215] --> Option will be set by PostScript interpreter D [26/Jan/2017:11:24:21 +0100] [Job 1215] Before page loop - %%Page: 1 1 D [26/Jan/2017:11:24:21 +0100] [Job 1215] Copying page 1... D [26/Jan/2017:11:24:21 +0100] [Job 1215] pagew = 559.0, pagel = 770.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842 D [26/Jan/2017:11:24:21 +0100] [Job 1215] PageLeft = 18.0, PageRight = 577.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] PageTop = 806.0, PageBottom = 36.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] PageWidth = 595.0, PageLength = 842.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] Found: %%EndSetup D [26/Jan/2017:11:24:21 +0100] [Job 1215] Inserting option code into "Setup" section. D [26/Jan/2017:11:24:21 +0100] [Job 1215] ----------- D [26/Jan/2017:11:24:21 +0100] [Job 1215] New page: %%Page: 1 1 D [26/Jan/2017:11:24:21 +0100] [Job 1215] Found: %%BeginPageSetup D [26/Jan/2017:11:24:21 +0100] [Job 1215] Inserting option code into "PageSetup" section. D [26/Jan/2017:11:24:21 +0100] [Job 1215] Copying page 2... D [26/Jan/2017:11:24:21 +0100] [Job 1215] pagew = 559.0, pagel = 770.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842 D [26/Jan/2017:11:24:21 +0100] [Job 1215] PageLeft = 18.0, PageRight = 577.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] PageTop = 806.0, PageBottom = 36.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] PageWidth = 595.0, PageLength = 842.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] New page found but previous not printed, print it now. D [26/Jan/2017:11:24:21 +0100] [Job 1215] Found: %%Page: 2 2 D [26/Jan/2017:11:24:21 +0100] [Job 1215] --> Output goes directly to the renderer now. D [26/Jan/2017:11:24:21 +0100] [Job 1215] Copying page 3... D [26/Jan/2017:11:24:21 +0100] [Job 1215] pagew = 559.0, pagel = 770.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842 D [26/Jan/2017:11:24:21 +0100] [Job 1215] PageLeft = 18.0, PageRight = 577.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] PageTop = 806.0, PageBottom = 36.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] PageWidth = 595.0, PageLength = 842.0 D [26/Jan/2017:11:24:21 +0100] [Job 1215] PID 22948 (pdftops) exited with no errors. D [26/Jan/2017:11:24:21 +0100] [Job 1215] Starting renderer with command: "cat" D [26/Jan/2017:11:24:21 +0100] [Job 1215] Starting process "kid3" (generation 1) D [26/Jan/2017:11:24:21 +0100] [Job 1215] Starting process "kid4" (generation 2) D [26/Jan/2017:11:24:21 +0100] [Job 1215] Starting process "renderer" (generation 2) D [26/Jan/2017:11:24:21 +0100] [Job 1215] JCL: %-12345X@PJL D [26/Jan/2017:11:24:21 +0100] [Job 1215] <job data> D [26/Jan/2017:11:24:21 +0100] [Job 1215] Connecting to printserver1.swabian.net:631 I [26/Jan/2017:11:24:21 +0100] [Job 1215] Connecting to printer. D [26/Jan/2017:11:24:21 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:21 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [26/Jan/2017:11:24:21 +0100] [Job 1215] Set job-printer-state-message to "Connecting to printer.", current level=INFO D [26/Jan/2017:11:24:21 +0100] Discarding unused job-progress event... D [26/Jan/2017:11:24:21 +0100] Discarding unused printer-state-changed event... D [26/Jan/2017:11:24:21 +0100] [Job 1215] update_reasons(attr=0(), s="-cups-certificate-error") D [26/Jan/2017:11:24:21 +0100] [Job 1215] update_reasons(attr=0(), s="-connecting-to-device") D [26/Jan/2017:11:24:21 +0100] [Job 1215] STATE: -connecting-to-device D [26/Jan/2017:11:24:21 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files" I [26/Jan/2017:11:24:21 +0100] [Job 1215] Connected to printer. D [26/Jan/2017:11:24:21 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [26/Jan/2017:11:24:21 +0100] [Job 1215] Set job-printer-state-message to "Connected to printer.", current level=INFO D [26/Jan/2017:11:24:21 +0100] [Job 1215] Connected to 172.18.0.41:631... D [26/Jan/2017:11:24:21 +0100] [Job 1215] Getting supported attributes... D [26/Jan/2017:11:24:21 +0100] Discarding unused job-progress event... D [26/Jan/2017:11:24:21 +0100] Discarding unused printer-state-changed event... D [26/Jan/2017:11:24:21 +0100] [Job 1215] Get-Printer-Attributes: server-error-version-not-supported (server-error-version-not-supported) D [26/Jan/2017:11:24:21 +0100] [Job 1215] Get-Printer-Attributes returned server-error-version-not-supported. I [26/Jan/2017:11:24:21 +0100] [Job 1215] Preparing to print. D [26/Jan/2017:11:24:21 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:21 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [26/Jan/2017:11:24:21 +0100] [Job 1215] Set job-printer-state-message to "Preparing to print.", current level=INFO D [26/Jan/2017:11:24:21 +0100] [Job 1215] The printer does not support IPP/2.0, trying IPP/1.1. D [26/Jan/2017:11:24:21 +0100] Discarding unused job-progress event... D [26/Jan/2017:11:24:21 +0100] Discarding unused printer-state-changed event... D [26/Jan/2017:11:24:21 +0100] [Job 1215] Getting supported attributes... D [26/Jan/2017:11:24:21 +0100] [Job 1215] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:21 +0100] [Job 1215] document-format-supported (1 values) D [26/Jan/2017:11:24:21 +0100] [Job 1215] [0] = "application/octet-stream" D [26/Jan/2017:11:24:21 +0100] [Job 1215] operations-supported (7 values) D [26/Jan/2017:11:24:21 +0100] [Job 1215] [0] = Print-Job D [26/Jan/2017:11:24:21 +0100] [Job 1215] [1] = Validate-Job D [26/Jan/2017:11:24:21 +0100] [Job 1215] [2] = Purge-Jobs D [26/Jan/2017:11:24:21 +0100] [Job 1215] [3] = Cancel-Job D [26/Jan/2017:11:24:21 +0100] [Job 1215] [4] = Get-Job-Attributes D [26/Jan/2017:11:24:21 +0100] [Job 1215] [5] = Get-Jobs D [26/Jan/2017:11:24:21 +0100] [Job 1215] [6] = Get-Printer-Attributes D [26/Jan/2017:11:24:21 +0100] [Job 1215] update_reasons(attr=1(none-report), s="(null)") D [26/Jan/2017:11:24:21 +0100] [Job 1215] STATE: -none D [26/Jan/2017:11:24:21 +0100] [Job 1215] final_content_type="application/vnd.cups-pdf", document_format="application/octet-stream" D [26/Jan/2017:11:24:21 +0100] [Job 1215] Validate-Job IPP/1.1 D [26/Jan/2017:11:24:21 +0100] [Job 1215] printer-uri="ipp://printserver1.swabian.net:631/LPT2" D [26/Jan/2017:11:24:21 +0100] [Job 1215] requesting-user-name="root" D [26/Jan/2017:11:24:21 +0100] [Job 1215] job-name="1215 - (stdin)" D [26/Jan/2017:11:24:21 +0100] [Job 1215] document-format="application/octet-stream" D [26/Jan/2017:11:24:21 +0100] [Job 1215] Adding all operation/job attributes. D [26/Jan/2017:11:24:21 +0100] [Job 1215] IPP/1.1 Validate-Job #3 D [26/Jan/2017:11:24:21 +0100] [Job 1215] ---- operation-attributes-tag ---- D [26/Jan/2017:11:24:21 +0100] [Job 1215] attributes-charset charset utf-8 D [26/Jan/2017:11:24:21 +0100] [Job 1215] attributes-natural-language naturalLanguage en-us D [26/Jan/2017:11:24:21 +0100] [Job 1215] printer-uri uri ipp://printserver1.swabian.net:631/LPT2 D [26/Jan/2017:11:24:21 +0100] [Job 1215] requesting-user-name nameWithoutLanguage root D [26/Jan/2017:11:24:21 +0100] [Job 1215] job-name nameWithoutLanguage 1215 - (stdin) D [26/Jan/2017:11:24:21 +0100] [Job 1215] document-format mimeMediaType application/octet-stream D [26/Jan/2017:11:24:21 +0100] [Job 1215] ---- job-attributes-tag ---- D [26/Jan/2017:11:24:21 +0100] [Job 1215] finishings enum none D [26/Jan/2017:11:24:21 +0100] [Job 1215] job-originating-host-name nameWithoutLanguage localhost D [26/Jan/2017:11:24:21 +0100] [Job 1215] job-uuid uri urn:uuid:3542e92d-aae6-34f7-5b1c-1ff7d9d7a9da D [26/Jan/2017:11:24:21 +0100] [Job 1215] number-up integer 1 D [26/Jan/2017:11:24:21 +0100] [Job 1215] ---- end-of-attributes-tag ---- D [26/Jan/2017:11:24:21 +0100] [Job 1215] Validate-Job: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:21 +0100] [Job 1215] Print-Job IPP/1.1 D [26/Jan/2017:11:24:21 +0100] [Job 1215] printer-uri="ipp://printserver1.swabian.net:631/LPT2" D [26/Jan/2017:11:24:21 +0100] [Job 1215] requesting-user-name="root" D [26/Jan/2017:11:24:21 +0100] [Job 1215] job-name="1215 - (stdin)" D [26/Jan/2017:11:24:21 +0100] [Job 1215] document-format="application/octet-stream" D [26/Jan/2017:11:24:21 +0100] [Job 1215] Adding all operation/job attributes. D [26/Jan/2017:11:24:21 +0100] [Job 1215] IPP/1.1 Print-Job #5 D [26/Jan/2017:11:24:21 +0100] [Job 1215] ---- operation-attributes-tag ---- D [26/Jan/2017:11:24:21 +0100] [Job 1215] attributes-charset charset utf-8 D [26/Jan/2017:11:24:21 +0100] [Job 1215] attributes-natural-language naturalLanguage en-us D [26/Jan/2017:11:24:21 +0100] [Job 1215] printer-uri uri ipp://printserver1.swabian.net:631/LPT2 D [26/Jan/2017:11:24:21 +0100] [Job 1215] requesting-user-name nameWithoutLanguage root D [26/Jan/2017:11:24:21 +0100] [Job 1215] job-name nameWithoutLanguage 1215 - (stdin) D [26/Jan/2017:11:24:21 +0100] [Job 1215] document-format mimeMediaType application/octet-stream D [26/Jan/2017:11:24:21 +0100] [Job 1215] document-format mimeMediaType application/octet-stream D [26/Jan/2017:11:24:21 +0100] [Job 1215] ---- job-attributes-tag ---- D [26/Jan/2017:11:24:21 +0100] [Job 1215] finishings enum none D [26/Jan/2017:11:24:21 +0100] [Job 1215] job-originating-host-name nameWithoutLanguage localhost D [26/Jan/2017:11:24:21 +0100] [Job 1215] job-uuid uri urn:uuid:3542e92d-aae6-34f7-5b1c-1ff7d9d7a9da D [26/Jan/2017:11:24:21 +0100] [Job 1215] number-up integer 1 D [26/Jan/2017:11:24:21 +0100] [Job 1215] ---- end-of-attributes-tag ---- D [26/Jan/2017:11:24:21 +0100] [Job 1215] Sending file using HTTP/1.1 chunking... D [26/Jan/2017:11:24:21 +0100] [Job 1215] update_reasons(attr=1(none-report), s="(null)") D [26/Jan/2017:11:24:21 +0100] [Job 1215] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:21 +0100] [Job 1215] (monitor) Get-Jobs: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:21 +0100] [Job 1215] (monitor) job-state=pending D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] update_reasons(attr=1(none-report), s="(null)") D [26/Jan/2017:11:24:22 +0100] [Job 1215] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:22 +0100] [Job 1215] (monitor) Get-Job-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:22 +0100] [Job 1215] (monitor) job-state=pending D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:22 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] ----------- D [26/Jan/2017:11:24:23 +0100] [Job 1215] New page: %%Page: 2 2 D [26/Jan/2017:11:24:23 +0100] [Job 1215] Found: %%Page: 2 2 D [26/Jan/2017:11:24:23 +0100] [Job 1215] --> Output goes to the FIFO buffer now. D [26/Jan/2017:11:24:23 +0100] [Job 1215] Found: %%BeginPageSetup D [26/Jan/2017:11:24:23 +0100] [Job 1215] Inserting option code into "PageSetup" section. D [26/Jan/2017:11:24:23 +0100] [Job 1215] Copying page 4... D [26/Jan/2017:11:24:23 +0100] [Job 1215] pagew = 559.0, pagel = 770.0 D [26/Jan/2017:11:24:23 +0100] [Job 1215] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842 D [26/Jan/2017:11:24:23 +0100] [Job 1215] PageLeft = 18.0, PageRight = 577.0 D [26/Jan/2017:11:24:23 +0100] [Job 1215] PageTop = 806.0, PageBottom = 36.0 D [26/Jan/2017:11:24:23 +0100] [Job 1215] PageWidth = 595.0, PageLength = 842.0 D [26/Jan/2017:11:24:23 +0100] [Job 1215] Wrote 4 pages... D [26/Jan/2017:11:24:23 +0100] [Job 1215] New page found but previous not printed, print it now. D [26/Jan/2017:11:24:23 +0100] [Job 1215] Found: %%Page: 3 3 D [26/Jan/2017:11:24:23 +0100] [Job 1215] --> Output goes directly to the renderer now. D [26/Jan/2017:11:24:23 +0100] [Job 1215] ----------- D [26/Jan/2017:11:24:23 +0100] [Job 1215] New page: %%Page: 3 3 D [26/Jan/2017:11:24:23 +0100] [Job 1215] Found: %%Page: 3 3 D [26/Jan/2017:11:24:23 +0100] [Job 1215] --> Output goes to the FIFO buffer now. D [26/Jan/2017:11:24:23 +0100] [Job 1215] Found: %%BeginPageSetup D [26/Jan/2017:11:24:23 +0100] [Job 1215] Inserting option code into "PageSetup" section. D [26/Jan/2017:11:24:23 +0100] [Job 1215] PID 22949 (pstops) exited with no errors. D [26/Jan/2017:11:24:23 +0100] [Job 1215] New page found but previous not printed, print it now. D [26/Jan/2017:11:24:23 +0100] [Job 1215] Found: %%Page: 4 4 D [26/Jan/2017:11:24:23 +0100] [Job 1215] --> Output goes directly to the renderer now. D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] ----------- D [26/Jan/2017:11:24:23 +0100] [Job 1215] New page: %%Page: 4 4 D [26/Jan/2017:11:24:23 +0100] [Job 1215] Found: %%Page: 4 4 D [26/Jan/2017:11:24:23 +0100] [Job 1215] --> Output goes to the FIFO buffer now. D [26/Jan/2017:11:24:23 +0100] [Job 1215] Found: %%BeginPageSetup D [26/Jan/2017:11:24:23 +0100] [Job 1215] Inserting option code into "PageSetup" section. D [26/Jan/2017:11:24:23 +0100] [Job 1215] Flushing FIFO. D [26/Jan/2017:11:24:23 +0100] [Job 1215] Closing renderer D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] renderer exited with status 0 D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] update_reasons(attr=1(none-report), s="(null)") D [26/Jan/2017:11:24:23 +0100] [Job 1215] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:23 +0100] [Job 1215] (monitor) Get-Job-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:23 +0100] [Job 1215] (monitor) job-state=completed D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] kid4 exited with status 0 D [26/Jan/2017:11:24:23 +0100] [Job 1215] kid3 finished D [26/Jan/2017:11:24:23 +0100] [Job 1215] kid3 exited with status 0 D [26/Jan/2017:11:24:23 +0100] [Job 1215] pdf-to-ps exited with status 0 D [26/Jan/2017:11:24:23 +0100] [Job 1215] Closing foomatic-rip. D [26/Jan/2017:11:24:23 +0100] [Job 1215] PID 22944 (/usr/lib/cups/filter/foomatic-rip) exited with no errors. D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 16384 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Read 10818 bytes... D [26/Jan/2017:11:24:23 +0100] [Job 1215] Print-Job: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:23 +0100] [Job 1215] Print job accepted - job ID 33554541. I [26/Jan/2017:11:24:23 +0100] [Job 1215] Waiting for job to complete. D [26/Jan/2017:11:24:23 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:23 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [26/Jan/2017:11:24:23 +0100] [Job 1215] Set job-printer-state-message to "Waiting for job to complete.", current level=INFO D [26/Jan/2017:11:24:23 +0100] Discarding unused job-progress event... D [26/Jan/2017:11:24:23 +0100] Discarding unused printer-state-changed event... D [26/Jan/2017:11:24:23 +0100] [Job 1215] update_reasons(attr=1(none-report), s="(null)") D [26/Jan/2017:11:24:23 +0100] [Job 1215] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:23 +0100] [Job 1215] Get-Job-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:23 +0100] [Job 1215] update_reasons(attr=1(none-report), s="(null)") D [26/Jan/2017:11:24:23 +0100] [Job 1215] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes) D [26/Jan/2017:11:24:23 +0100] [Job 1215] ATTR: auth-info-required=none D [26/Jan/2017:11:24:23 +0100] load_ppd: Loading /var/cache/cups/E360d.data... D [26/Jan/2017:11:24:23 +0100] cupsdRegisterPrinter(p=0x557750f23ed0(E360d)) D [26/Jan/2017:11:24:23 +0100] Registering "Lexmark E360d Foomatic/Postscript @ alpha" with DNS-SD type "_printer._tcp". D [26/Jan/2017:11:24:23 +0100] Registering "Lexmark E360d Foomatic/Postscript @ alpha" with DNS-SD type "_ipps._tcp". D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-type=0x80B01E D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-state=4 D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Duplex=T D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Color=T D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" TLS=1.2 D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" UUID=e65febf1-6c2d-37ec-515f-8223cbcaa78c D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" product=(Lexmark E360dn) D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" priority=0 D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" adminurl=https://alpha.local:631/printers/E360d D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" ty=Unknown D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" rp=printers/E360d D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" qtotal=1 D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" txtvers=1 D [26/Jan/2017:11:24:23 +0100] Registering "Lexmark E360d Foomatic/Postscript @ alpha" with DNS-SD type "_ipp._tcp". D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-type=0x80B01E D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" printer-state=4 D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Duplex=T D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" Color=T D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" TLS=1.2 D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" UUID=e65febf1-6c2d-37ec-515f-8223cbcaa78c D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" pdl=application/octet-stream,application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" product=(Lexmark E360dn) D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" priority=0 D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" adminurl=https://alpha.local:631/printers/E360d D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" ty=Unknown D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" rp=printers/E360d D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" qtotal=1 D [26/Jan/2017:11:24:23 +0100] DNS_SD "Lexmark E360d Foomatic/Postscript @ alpha" txtvers=1 D [26/Jan/2017:11:24:23 +0100] cupsdMarkDirty(P----) D [26/Jan/2017:11:24:23 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [26/Jan/2017:11:24:23 +0100] [Job 1215] PID 22945 (/usr/lib/cups/backend/ipp) exited with no errors. D [26/Jan/2017:11:24:23 +0100] [Job 1215] time-at-completed=1485426263 D [26/Jan/2017:11:24:23 +0100] Discarding unused job-completed event... I [26/Jan/2017:11:24:23 +0100] [Job 1215] Job completed. D [26/Jan/2017:11:24:23 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:23 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [26/Jan/2017:11:24:23 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [26/Jan/2017:11:24:23 +0100] Discarding unused printer-state-changed event... D [26/Jan/2017:11:24:23 +0100] cupsdMarkDirty(---J-) D [26/Jan/2017:11:24:23 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [26/Jan/2017:11:24:24 +0100] [Job 1215] Unloading... the ppd used is also original: # rpm -qf /usr/share/cups/model/OpenPrintingPPDs/postscript/Lexmark-E360d.Postscript.ppd.gz OpenPrintingPPDs-postscript-4.0.0.2-4.1.noarch and finally the postscript data (at least the beginning): %!PS-Adobe-3.0 %Produced by poppler pdftops version: 0.43.0 (http://poppler.freedesktop.org) %%Creator: texttopdf/1.8.2 %%LanguageLevel: 3 %%DocumentSuppliedResources: (atend) %%DocumentMedia: A4 595 842 0 () () %%For: (root) %%Title: (stdin) %RBINumCopies: 1 %%Pages: (atend) %%BoundingBox: (atend) %%EndComments %%BeginProlog %%BeginResource: procset xpdf 3.00 0 %%Copyright: Copyright 1996-2011 Glyph & Cog, LLC /xpdf 75 dict def xpdf begin % PDF special state /pdfDictSize 15 def /pdfSetup { /setpagedevice where { pop 2 dict begin /Policies 1 dict dup begin /PageSize 6 def end def { /Duplex true def } if currentdict end setpagedevice } { pop } ifelse } def /pdfSetupPaper { % Change paper size, but only if different from previous paper size otherwise % duplex fails. PLRM specifies a tolerance of 5 pts when matching paper size % so we use the same when checking if the size changes. /setpagedevice where { pop currentpagedevice /PageSize known { 2 copy currentpagedevice /PageSize get aload pop exch 4 1 roll sub abs 5 gt 3 1 roll sub abs 5 gt or } { true } ifelse { 2 array astore 2 dict begin /PageSize exch def /ImagingBBox null def currentdict end setpagedevice } { pop pop } ifelse } { pop } ifelse } def /pdfStartPage { pdfDictSize dict begin /pdfFillCS [] def /pdfFillXf ?Xc dfLastStroke false def } def /SC { pdfLastStroke not { pdfStrokeCS setcolorspace } if dup /pdfStroke exch def aload pop pdfStrokeXform setcolor /pdfLastStroke true def /pdfLastFill false def } def /op { /pdfFillOP exch def pdfLastFill { pdfFillOP setoverprint } if } def /OP { /pdfStrokeOP exch def pdfLastStroke { pdfStrokeOP setoverprint } if } def /fCol { pdfLastFill not { pdfFillCS setcolorspace pdfFill aload pop pdfFillXform setcolor pdfFillOP setoverprint /pdfLastFill true def /pdfLastStroke false def } if } def /sCol ?X c pop } ifelse } forall /Encoding exch def currentdict end definefont pop } def /pdfMakeFont16 { exch findfont dup length dict begin { 1 index /FID ne { def } { pop pop } ifelse } forall /WMode exch def currentdict end definefont pop } def /pdfMakeFont16L3 { 1 index /CIDFont resourcestatus { pop pop 1 index /CIDFont findresource /CIDFontType known } { false } ifelse { 0 eq { /Identity-H } { /Identity-V } ifelse exch 1 array astore composefont pop } { pdfMakeFont16 } ifelse } def % graphics state operators /q { gsave pdfDictSize dict begin } def /Q { end grestore /pdfLastFill where { pop pdfLastFill { pdfFillOP setoverprint } { pdfStrokeOP setoverprint } ifelse } if /pdfOPM where { pop pdfOPM /setoverprintmode where{pop setoverprintmode}{pop}ifelse } if } def /cm { concat } def /d { setdash } def /i { setflat } def /j { setlinejoin } def /J { setlinecap } def /M { setmiterlimit } def /w { setlinewidth } def % path segment operators /m { moveto } def /l { lineto } def /c { curveto } def /re { 4 2 ro ?X2c g exch def } def % text positioning operators /Td { pdfTextMat transform moveto } def /Tm { /pdfTextMat exch def } def % text string operators /xyshow where { pop /xyshow2 { dup length array 0 2 2 index length 1 sub { 2 index 1 index 2 copy get 3 1 roll 1 add get pdfTextMat dtransform 4 2 roll 2 copy 6 5 roll put 1 add 3 1 roll dup 4 2 roll put } for exch pop xyshow } def }{ /xyshow2 { currentfont /FontType get 0 eq { 0 2 3 index length 1 sub { currentpoint 4 index 3 index 2 getinterval show moveto 2 copy get 2 index 3 2 roll 1 add get pdfTextMat dtransform rmoveto } for } { 0 1 3 index length 1 sub { currentpo ?XJc p } def } ifelse /cshow where { pop /xycp { 0 3 2 roll { pop pop currentpoint 3 2 roll 1 string dup 0 4 3 roll put false charpath moveto 2 copy get 2 index 2 index 1 add get pdfTextMat dtransform rmoveto 2 add } exch cshow pop pop } def }{ /xycp { currentfont /FontType get 0 eq { 0 2 3 index length 1 sub { currentpoint 4 index 3 index 2 getinterval false charpath moveto 2 copy get 2 index 3 2 roll 1 add get pdfTextMat dtransform rmoveto } for } { 0 1 3 index length 1 sub { currentpoint 4 index 3 index 1 getinterval false charpath moveto 2 copy 2 mul get 2 index 3 2 roll 2 mul 1 add get pdfTextMat dtransform rmoveto } for } ifelse pop pop } def } ifelse /Tj { fCol 0 pdfTextRise pdfTextMat dtransform rmoveto currentpoint 4 2 roll pdfTextRender 1 and 0 eq { 2 copy xyshow2 } if pdfTextRender 3 and dup 1 eq exch 2 eq or { 3 index 3 index moveto 2 copy currentfont /FontType get 3 eq { fCol } { sCol } ifelse xycp currentpoint stroke moveto } if pdfTextRender 4 and 0 ne { 4 2 roll moveto xycp /pdfTextClipPath [ pdfTextClipPath aload pop {/moveto cvx} {/lineto cvx} {/ ?X^c perators /pdfImBuf 100 string def /pdfImStr { 2 copy exch length lt { 2 copy get exch 1 add exch } { () } ifelse } def /skipEOD { { currentfile pdfImBuf readline not { pop exit } if (%-EOD-) eq { exit } if } loop } def /pdfIm { image skipEOD } def /pdfMask { /ReusableStreamDecode filter skipEOD /maskStream exch def } def /pdfMaskEnd { maskStream closefile } def /pdfMaskInit { /maskArray exch def /maskIdx 0 def } def /pdfMaskSrc { maskIdx maskArray length lt { maskArray maskIdx get /maskIdx maskIdx 1 add def } { () } ifelse } def /pdfImM { fCol imagemask skipEOD } def /pr { 2 index 2 index 3 2 roll putinterval 4 add } def /pdfImClip { gsave 0 2 4 index length 1 sub { dup 4 index exch 2 copy get 5 index div put 1 add 3 index exch 2 copy get 3 index div put } for pop pop rectclip } def /pdfImClipEnd { grestor ?X?c ?Prk? funcCol sc dup 4 index exch mat transform m 3 index 3 index mat transform l 1 index 3 index mat transform l mat transform l pop pop h f* } ifelse } def /axialCol { dup 0 lt { pop t0 } { dup 1 gt { pop t1 } { dt mul t0 add } ifelse } ifelse func n array astore } def /axialSH { dup 0 eq { true } { dup 8 eq { false } { 2 index axialCol 2 index axialCol colordelta } ifelse } ifelse { 1 add 3 1 roll 2 copy add 0.5 mul ?X?c l yMin sub dy mul dx div add yMin l h f* } { exch 2 copy xMin sub dx mul dy div add xMin exch m xMax sub dx mul dy div add xMax exch l exch 2 copy xMax sub dx mul dy div add xMax exch l xMin sub dx mul dy div add xMin exch l h f* } ifelse } ifelse } def /radialCol { dup t0 lt { pop t0 } { dup t1 gt { pop t1 } if } ifelse func n array astore } def /radialSH { dup 0 eq { true } { dup 8 eq { false } { 2 index dt mul t0 add radialCol 2 index dt mul t0 add radialCol colordelta } ifelse } ifelse { 1 add 3 1 roll 2 copy add 0.5 mul dup 4 3 roll exch 4 index radialSH exch 3 2 roll radialSH } { pop 2 copy add 0.5 mul dt mul t0 add radialCol sc encl { exch dup dx mul x0 add exch dup dy mul y0 add exch dr mul r0 add 0 360 arc h dup dx mul x0 add exch dup dy mul y0 add exch dr mul r0 add 360 0 arcn h f } { 2 copy dup dx mul x0 add exch dup dy mul y0 add exch dr mul r0 add a1 a2 arcn dup dx mul x0 ?X?c p defineresource pop end 10 dict begin begincmap /CMapType 1 def /CMapName /Identity-V def /CIDSystemInfo 3 dict dup begin /Registry (Adobe) def /Ordering (Identity) def /Supplement 0 def end def /WMode 1 def 1 begincodespacerange <0000> <ffff> endcodespacerange 0 usefont 1 begincidrange <0000> <ffff> 0 endcidrange endcmap currentdict CMapName exch /CMap defineresource pop end end %%EndProlog %%BeginSetup % Disable CTRL-D as an end-of-file marker... userdict dup(\004)cvn{}put (\004\004)cvn{}put [{ %%BeginFeature: *Resolution 600x600dpi <</HWResolution[600 600]>>setpagedevice %%EndFeature } stopped cleartomark [{ %%BeginFeature: *PageSize A4 <</PageSize[595 842]/ImagingBBox null>>setpagedevice %%EndFeature } stopped cleartoma ?X.i ose <</ManualFeed false /MediaPosition 3>>setpagedevice %%EndFeature } stopped cleartomark [{ %%BeginFeature: *Duplex None <</Duplex false>>setpagedevice %%EndFeature } stopped cleartomark % x y w h ESPrc - Clip to a rectangle. userdict/ESPrc/rectclip where{pop/rectclip load} {{newpath 4 2 roll moveto 1 index 0 rlineto 0 exch rlineto neg 0 rlineto closepath clip newpath}bind}ifelse put % x y w h ESPrf - Fill a rectangle. userdict/ESPrf/rectfill where{pop/rectfill load} {{gsave newpath 4 2 roll moveto 1 index 0 rlineto 0 exch rlineto neg 0 rlineto closepath fill grestore}bind}ifelse put % x y w h ESPrs - Stroke a rectangle. userdict/ESPrs/rectstroke where{pop/rectstroke load} {{gsave newpath 4 2 roll moveto 1 index 0 rlineto 0 exch rlineto neg 0 rlineto closepath stroke grestore}bind}ifelse put userdict/ESPwl{}bind put xpdf begin %%BeginResource: font SourceCodePro-Bold /CIDInit /ProcSet findresource begin 20 dict begin /CIDFontName /SourceCodePro-Bold def /CIDFontType 0 def /CIDSystemInfo 3 dict dup begin /Registry (Adobe) def /Ordering (Identity) def /Supplement 0 def end def /FontMatrix [0.001 0 0 0.001 0 0] def /FontBBox [-208 -400 808 1060] def /FontInfo 1 dict dup begin /FSType 8 def end def /CIDCount 1549 def /FDBytes 1 def /GDBytes 3 def /CIDMapOffset 0 def /FDArray 1 array dup 0 10 dict begin /FontType 1 def /FontMatrix [1 0 0 1 0 0] def /PaintType 0 def /Private 32 dict begin /B ?Xpi 01c0c00001c7900001cbe00001d1a 00001d6c00001df100001e4f00001ecb00001efa00001f43 00001f7600001fed0000204f00002096000020cd00002135 00002195000021ec0000224c000022a900002303000023bb 00002410000024450000249a000024e00000252900002587 000025c40000261c0000267a000026d8000027140000278a 000027e60000282800002867000028de0000293c00002998 000029cf00002a3400002a9a00002b0d00002b8600002c16 00002c6600002ce500002d7500002e1000002e8200002ef3 00002f5000002fcd0000304c000030ca00003164000031f6 0000326e000032fe0000338c00003434000034d300003555 000035a60000360900003666000036d000003738000037c0 0000382d000038a8000039210000399f00003a0800003a5a 00003aa000003b1c00003b8000003bed00003c3c00003c8d 00003ceb00003d4800003da600003ddf00003e4900003e8f 00003eed00003f3400003fa0000040020000406c000040d5 0000415e000041da0000423c000042850000430700004397 00004432000044a400004523000045b100004618000046a6 0000472700004784000047e2000048290000487d000048d4 0000493500004981000049cf00004a2a00004a8d00004aec 00004b260000 ?Xox ...
participants (1)
-
Paul Neuwirth