You are not logged in.

#1 2021-12-25 02:03:44

igronin
Member
Registered: 2021-12-25
Posts: 4

CUPS - Filter failed after - yay -Syu

After I updated my system printer stop working

in http://localhost:631/printers/Kyocera_FS-1040
I get "Filter failed"

lpinfo -v

file cups-brf:/
network lpd
network beh
network http
network ipp
direct hp
network socket
network https
direct usb://Kyocera/FS-1040?serial=V246501534
network ipps
direct hpfax

I have installed
yay cups
yay rastertokpsl

I got logs but dont understand the problem from them

I [25/Dec/2021:10:00:30 +0800] Saving job.cache...
D [25/Dec/2021:10:00:30 +0800] cupsdSetBusyState: newbusy="Not busy", busy="Printing jobs and dirty files"
D [25/Dec/2021:10:00:30 +0800] Creating KeepAlive/PID file "/var/cache/cups/org.cups.cupsd".
I [25/Dec/2021:10:00:30 +0800] Saving job.cache...
D [25/Dec/2021:10:00:30 +0800] cupsdStopSelect()
I [25/Dec/2021:10:00:30 +0800] Listening to 0.0.0.0:631 (IPv4)
I [25/Dec/2021:10:00:30 +0800] Listening to [v1.::]:631 (IPv6)
I [25/Dec/2021:10:00:30 +0800] Listening to /run/cups/cups.sock (Domain)
I [25/Dec/2021:10:00:30 +0800] Remote access is enabled.
D [25/Dec/2021:10:00:30 +0800] Added auto ServerAlias k55vddream
I [25/Dec/2021:10:00:30 +0800] Loaded configuration file "/etc/cups/cupsd.conf"
D [25/Dec/2021:10:00:30 +0800] Using keychain "/etc/cups/ssl" for server name "k55vddream".
I [25/Dec/2021:10:00:30 +0800] Using default TempDir of /var/spool/cups/tmp...
I [25/Dec/2021:10:00:30 +0800] Configured for up to 100 clients.
I [25/Dec/2021:10:00:30 +0800] Allowing up to 100 client connections per host.
I [25/Dec/2021:10:00:30 +0800] Using policy "default" as the default.
I [25/Dec/2021:10:00:30 +0800] Full reload is required.
I [25/Dec/2021:10:00:30 +0800] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 78 types, 118 filters...
D [25/Dec/2021:10:00:30 +0800] Loading printer Kyocera_FS-1040...
D [25/Dec/2021:10:00:30 +0800] load_ppd: Loading /var/cache/cups/Kyocera_FS-1040.data...
D [25/Dec/2021:10:00:30 +0800] Kyocera_FS-1040: pdl='application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster,image/urf'
D [25/Dec/2021:10:00:30 +0800] cupsdRegisterPrinter(p=0x55f05d1f6370(Kyocera_FS-1040))
D [25/Dec/2021:10:00:30 +0800] Queue Kyocera_FS-1040 uses a printer driver, which is deprecated.
W [25/Dec/2021:10:00:30 +0800] Printer drivers are deprecated and will stop working in a future version of CUPS. See [url]https://github.com/OpenPrinting/cups/issues/103[/url]
I [25/Dec/2021:10:00:30 +0800] Loading job cache file "/var/cache/cups/job.cache"...
D [25/Dec/2021:10:00:30 +0800] [Job 217] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 218] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 219] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 220] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 221] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 222] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 223] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 224] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 225] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 226] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 227] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 228] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 229] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 230] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 231] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 231] Loading attributes...
D [25/Dec/2021:10:00:30 +0800] [Job 232] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 232] Loading attributes...
D [25/Dec/2021:10:00:30 +0800] [Job 233] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 233] Loading attributes...
D [25/Dec/2021:10:00:30 +0800] [Job 234] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 234] Loading attributes...
D [25/Dec/2021:10:00:30 +0800] [Job 235] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 235] Loading attributes...
D [25/Dec/2021:10:00:30 +0800] [Job 236] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 236] Loading attributes...
D [25/Dec/2021:10:00:30 +0800] [Job 237] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 237] Loading attributes...
D [25/Dec/2021:10:00:30 +0800] [Job 238] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 238] Loading attributes...
D [25/Dec/2021:10:00:30 +0800] [Job 239] Loading from cache...
D [25/Dec/2021:10:00:30 +0800] [Job 239] Loading attributes...
I [25/Dec/2021:10:00:30 +0800] Full reload complete.
D [25/Dec/2021:10:00:30 +0800] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [25/Dec/2021:10:00:30 +0800] Cleaning out old files in "/var/spool/cups/tmp".
D [25/Dec/2021:10:00:30 +0800] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
I [25/Dec/2021:10:00:30 +0800] Cleaning out old files in "/var/cache/cups".
D [25/Dec/2021:10:00:30 +0800] service_checkin: pid=5255
D [25/Dec/2021:10:00:30 +0800] service_checkin: 1 listeners.
D [25/Dec/2021:10:00:30 +0800] service_add_listener: Listener #1 at fd 3, "/run/cups/cups.sock".
D [25/Dec/2021:10:00:30 +0800] service_add_listener: Matched existing listener #1 to /run/cups/cups.sock.
D [25/Dec/2021:10:00:30 +0800] Creating KeepAlive/PID file "/var/cache/cups/org.cups.cupsd".
D [25/Dec/2021:10:00:30 +0800] Calling FindDeviceById(cups-Kyocera_FS-1040)
D [25/Dec/2021:10:00:30 +0800] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [25/Dec/2021:10:00:30 +0800] Using profile ID "Kyocera_FS-1040-Gray..".
D [25/Dec/2021:10:00:30 +0800] Calling CreateProfile(Kyocera_FS-1040-Gray..,temp)
W [25/Dec/2021:10:00:30 +0800] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [25/Dec/2021:10:00:30 +0800] Registering ICC color profiles for "Kyocera_FS-1040".
D [25/Dec/2021:10:00:30 +0800] Calling CreateDevice(cups-Kyocera_FS-1040,temp)
W [25/Dec/2021:10:00:30 +0800] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [25/Dec/2021:10:00:30 +0800] Listening to 0.0.0.0:631 on fd 8...
I [25/Dec/2021:10:00:30 +0800] Listening to [v1.::]:631 on fd 9...
I [25/Dec/2021:10:00:30 +0800] Listening to /run/cups/cups.sock on fd 3...
I [25/Dec/2021:10:00:30 +0800] Resuming new connection processing...
D [25/Dec/2021:10:00:30 +0800] Avahi server connection now available, registering printers for Bonjour broadcasting.
I [25/Dec/2021:10:00:30 +0800] Defaulting to "DNSSDHostName k55vddream.local".
D [25/Dec/2021:10:00:30 +0800] Registering "Kyocera FS-1040 @ k55vddream" with DNS-SD type "_printer._tcp".
D [25/Dec/2021:10:00:30 +0800] Registering "Kyocera FS-1040 @ k55vddream" with DNS-SD type "_ipps._tcp".
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" printer-type=0x9046
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" Copies=T
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" mopria-certified=1.3
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" URF=V1.4,CP1,W8,PQ4,RS600,FN3
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" TLS=1.2
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" UUID=2339c250-6c3b-354d-63b4-dd615838edeb
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" pdl=application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster,image/urf
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" product=(FS-1040)
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" priority=0
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" note=d1-10
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" adminurl=https://k55vddream.local.:631/printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" ty=Kyocera FS-1040 (KPSL)
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" rp=printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" qtotal=1
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" txtvers=1
D [25/Dec/2021:10:00:30 +0800] Registering "Kyocera FS-1040 @ k55vddream" with DNS-SD type "_ipp._tcp".
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" printer-type=0x9046
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" Copies=T
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" mopria-certified=1.3
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" URF=V1.4,CP1,W8,PQ4,RS600,FN3
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" TLS=1.2
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" UUID=2339c250-6c3b-354d-63b4-dd615838edeb
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" pdl=application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster,image/urf
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" product=(FS-1040)
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" priority=0
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" note=d1-10
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" adminurl=https://k55vddream.local.:631/printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" ty=Kyocera FS-1040 (KPSL)
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" rp=printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" qtotal=1
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" txtvers=1
D [25/Dec/2021:10:00:30 +0800] Registering "Kyocera FS-1040 @ k55vddream" with DNS-SD type "_printer._tcp".
D [25/Dec/2021:10:00:30 +0800] Registering "Kyocera FS-1040 @ k55vddream" with DNS-SD type "_ipps._tcp".
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" printer-type=0x9046
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" Copies=T
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" mopria-certified=1.3
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" URF=V1.4,CP1,W8,PQ4,RS600,FN3
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" TLS=1.2
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" UUID=2339c250-6c3b-354d-63b4-dd615838edeb
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" pdl=application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster,image/urf
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" product=(FS-1040)
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" priority=0
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" note=d1-10
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" adminurl=https://k55vddream.local.:631/printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" ty=Kyocera FS-1040 (KPSL)
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" rp=printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" qtotal=1
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" txtvers=1
D [25/Dec/2021:10:00:30 +0800] Registering "Kyocera FS-1040 @ k55vddream" with DNS-SD type "_ipp._tcp".
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" printer-type=0x9046
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" Copies=T
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" mopria-certified=1.3
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" URF=V1.4,CP1,W8,PQ4,RS600,FN3
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" TLS=1.2
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" UUID=2339c250-6c3b-354d-63b4-dd615838edeb
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" pdl=application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster,image/urf
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" product=(FS-1040)
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" priority=0
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" note=d1-10
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" adminurl=https://k55vddream.local.:631/printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" ty=Kyocera FS-1040 (KPSL)
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" rp=printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" qtotal=1
D [25/Dec/2021:10:00:30 +0800] DNS_SD "Kyocera FS-1040 @ k55vddream" txtvers=1
D [25/Dec/2021:10:00:30 +0800] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [25/Dec/2021:10:00:30 +0800] cupsdAddCert: Adding certificate for PID 0
D [25/Dec/2021:10:00:30 +0800] Discarding unused server-started event...
D [25/Dec/2021:10:00:30 +0800] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [25/Dec/2021:10:00:31 +0800] Report: clients=0
D [25/Dec/2021:10:00:31 +0800] Report: jobs=23
D [25/Dec/2021:10:00:31 +0800] Report: jobs-active=9
D [25/Dec/2021:10:00:31 +0800] Report: printers=1
D [25/Dec/2021:10:00:31 +0800] Report: stringpool-string-count=1189
D [25/Dec/2021:10:00:31 +0800] Report: stringpool-alloc-bytes=11136
D [25/Dec/2021:10:00:31 +0800] Report: stringpool-total-bytes=23736
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [25/Dec/2021:10:00:33 +0800] [Client 1] Server address is "/run/cups/cups.sock".
D [25/Dec/2021:10:00:33 +0800] [Client 1] Accepted from localhost (Domain)
D [25/Dec/2021:10:00:33 +0800] [Client 1] Waiting for request.
D [25/Dec/2021:10:00:33 +0800] [Client 1] POST / HTTP/1.1
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=200, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] No authentication data provided.
D [25/Dec/2021:10:00:33 +0800] [Client 1] 2.0 CUPS-Get-Default 1
D [25/Dec/2021:10:00:33 +0800] CUPS-Get-Default
D [25/Dec/2021:10:00:33 +0800] [Client 1] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost.
D [25/Dec/2021:10:00:33 +0800] [Client 1] Content-Length: 1203
D [25/Dec/2021:10:00:33 +0800] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Dec/2021:10:00:33 +0800] [Client 1] con->http=0x55f05d2cf5e0
D [25/Dec/2021:10:00:33 +0800] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1203, response=0x55f05d2bcf60(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Dec/2021:10:00:33 +0800] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Dec/2021:10:00:33 +0800] [Client 1] bytes=0, http_state=0, data_remaining=1203
D [25/Dec/2021:10:00:33 +0800] [Client 1] Flushing write buffer.
D [25/Dec/2021:10:00:33 +0800] [Client 1] New state is HTTP_STATE_WAITING
D [25/Dec/2021:10:00:33 +0800] [Client 1] Waiting for request.
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [25/Dec/2021:10:00:33 +0800] [Client 1] POST / HTTP/1.1
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=200, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] No authentication data provided.
D [25/Dec/2021:10:00:33 +0800] [Client 1] 2.0 Get-Printer-Attributes 2
D [25/Dec/2021:10:00:33 +0800] Get-Printer-Attributes ipp://localhost:631/printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:33 +0800] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/Kyocera_FS-1040) from localhost.
D [25/Dec/2021:10:00:33 +0800] [Client 1] Content-Length: 1203
D [25/Dec/2021:10:00:33 +0800] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Dec/2021:10:00:33 +0800] [Client 1] con->http=0x55f05d2cf5e0
D [25/Dec/2021:10:00:33 +0800] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1203, response=0x55f05d2ad720(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Dec/2021:10:00:33 +0800] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Dec/2021:10:00:33 +0800] [Client 1] bytes=0, http_state=0, data_remaining=1203
D [25/Dec/2021:10:00:33 +0800] [Client 1] Flushing write buffer.
D [25/Dec/2021:10:00:33 +0800] [Client 1] New state is HTTP_STATE_WAITING
D [25/Dec/2021:10:00:33 +0800] [Client 1] Waiting for request.
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [25/Dec/2021:10:00:33 +0800] [Client 1] POST /printers/Kyocera_FS-1040 HTTP/1.1
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=200, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] No authentication data provided.
D [25/Dec/2021:10:00:33 +0800] [Client 1] 2.0 Get-Printer-Attributes 3
D [25/Dec/2021:10:00:33 +0800] Get-Printer-Attributes ipp://localhost/printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:33 +0800] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Kyocera_FS-1040) from localhost.
D [25/Dec/2021:10:00:33 +0800] [Client 1] Content-Length: 13769
D [25/Dec/2021:10:00:33 +0800] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Dec/2021:10:00:33 +0800] [Client 1] con->http=0x55f05d2cf5e0
D [25/Dec/2021:10:00:33 +0800] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=13769, response=0x55f05d2bcf60(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Dec/2021:10:00:33 +0800] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Dec/2021:10:00:33 +0800] [Client 1] bytes=0, http_state=0, data_remaining=13769
D [25/Dec/2021:10:00:33 +0800] [Client 1] Flushing write buffer.
D [25/Dec/2021:10:00:33 +0800] [Client 1] New state is HTTP_STATE_WAITING
D [25/Dec/2021:10:00:33 +0800] [Client 1] Waiting for request.
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [25/Dec/2021:10:00:33 +0800] [Client 1] POST /printers/Kyocera_FS-1040 HTTP/1.1
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=200, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] No authentication data provided.
D [25/Dec/2021:10:00:33 +0800] [Client 1] 2.0 Create-Job 4
D [25/Dec/2021:10:00:33 +0800] Create-Job ipp://localhost/printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:33 +0800] cupsdMarkDirty(---J-)
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [25/Dec/2021:10:00:33 +0800] [Job 240] Applying default options...
D [25/Dec/2021:10:00:33 +0800] add_job: requesting-user-name="ihar"
I [25/Dec/2021:10:00:33 +0800] [Job 240] Adding start banner page "none".
D [25/Dec/2021:10:00:33 +0800] Discarding unused job-created event...
I [25/Dec/2021:10:00:33 +0800] [Job 240] Queued on "Kyocera_FS-1040" by "ihar".
D [25/Dec/2021:10:00:33 +0800] [Client 1] Returning IPP successful-ok for Create-Job (ipp://localhost/printers/Kyocera_FS-1040) from localhost.
D [25/Dec/2021:10:00:33 +0800] [Client 1] Content-Length: 201
D [25/Dec/2021:10:00:33 +0800] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Dec/2021:10:00:33 +0800] [Client 1] con->http=0x55f05d2cf5e0
D [25/Dec/2021:10:00:33 +0800] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=201, response=0x55f05d2c8050(IPP_STATE_IDLE), pipe_pid=0, file=-1
D [25/Dec/2021:10:00:33 +0800] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Dec/2021:10:00:33 +0800] [Client 1] bytes=0, http_state=0, data_remaining=201
D [25/Dec/2021:10:00:33 +0800] [Client 1] Flushing write buffer.
D [25/Dec/2021:10:00:33 +0800] [Client 1] New state is HTTP_STATE_WAITING
D [25/Dec/2021:10:00:33 +0800] [Client 1] Waiting for request.
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Dec/2021:10:00:33 +0800] [Client 1] POST /printers/Kyocera_FS-1040 HTTP/1.1
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=200, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] No authentication data provided.
D [25/Dec/2021:10:00:33 +0800] [Client 1] 2.0 Send-Document 5
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] [Client 1] Read: status=100, state=6
D [25/Dec/2021:10:00:33 +0800] Send-Document ipp://localhost:631/printers/Kyocera_FS-1040
D [25/Dec/2021:10:00:33 +0800] cupsdIsAuthorized: requesting-user-name="ihar"
D [25/Dec/2021:10:00:33 +0800] [Job 240] Auto-typing file...
D [25/Dec/2021:10:00:33 +0800] [Job 240] Request file type is application/pdf.
D [25/Dec/2021:10:00:33 +0800] cupsdMarkDirty(---J-)
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [25/Dec/2021:10:00:33 +0800] [Job 240] File of type application/pdf queued by "ihar".
I [25/Dec/2021:10:00:33 +0800] [Job 240] Adding end banner page "none".
D [25/Dec/2021:10:00:33 +0800] cupsdMarkDirty(---J-)
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [25/Dec/2021:10:00:33 +0800] [Job 240] time-at-processing=1640397633
D [25/Dec/2021:10:00:33 +0800] cupsdMarkDirty(---J-)
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [25/Dec/2021:10:00:33 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:33 +0800] [Job 240] 3 filters for job:
D [25/Dec/2021:10:00:33 +0800] [Job 240] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [25/Dec/2021:10:00:33 +0800] [Job 240] gstoraster (application/vnd.cups-pdf to application/vnd.cups-raster, cost 99)
D [25/Dec/2021:10:00:33 +0800] [Job 240] /usr/lib/cups/filter/rastertokpsl-fixed (application/vnd.cups-raster to printer/Kyocera_FS-1040, cost 0)
D [25/Dec/2021:10:00:33 +0800] [Job 240] job-sheets=none,none
D [25/Dec/2021:10:00:33 +0800] [Job 240] argv[0]="Kyocera_FS-1040"
D [25/Dec/2021:10:00:33 +0800] [Job 240] argv[1]="240"
D [25/Dec/2021:10:00:33 +0800] [Job 240] argv[2]="ihar"
D [25/Dec/2021:10:00:33 +0800] [Job 240] argv[3]="InternalRegusOSA_PT Production Focus Studio (1).pdf"
D [25/Dec/2021:10:00:33 +0800] [Job 240] argv[4]="1"
D [25/Dec/2021:10:00:33 +0800] [Job 240] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:b262f455-cf66-3254-4fb6-e6d0c1476a31 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1640397633 time-at-processing=1640397633 document-name-supplied=InternalRegusOSA_PT\\ Production\\ Focus\\ Studio\\ (1).pdf"
D [25/Dec/2021:10:00:33 +0800] [Job 240] argv[6]="/var/spool/cups/d00240-001"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[3]="CUPS_REQUESTROOT=/var/spool/cups"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[4]="CUPS_SERVERBIN=/usr/lib/cups"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[5]="CUPS_SERVERROOT=/etc/cups"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[6]="CUPS_STATEDIR=/run/cups"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[7]="HOME=/var/spool/cups/tmp"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[9]="SERVER_ADMIN=root@k55vddream"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[10]="SOFTWARE=CUPS/2.4.0"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[12]="USER=root"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[13]="CUPS_MAX_MESSAGE=2047"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[14]="CUPS_SERVER=/run/cups/cups.sock"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[16]="IPP_PORT=631"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[17]="CHARSET=utf-8"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[18]="LANG=en_US.UTF-8"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[19]="PPD=/etc/cups/ppd/Kyocera_FS-1040.ppd"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[20]=""
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[21]="CONTENT_TYPE=application/pdf"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[22]="DEVICE_URI=usb://Kyocera/FS-1040?serial=V246501534"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[23]="PRINTER_INFO=Kyocera FS-1040"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[24]="PRINTER_LOCATION=d1-10"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[25]="PRINTER=Kyocera_FS-1040"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[26]="PRINTER_STATE_REASONS=none"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[27]="CUPS_FILETYPE=document"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[28]="FINAL_CONTENT_TYPE=application/vnd.cups-raster"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[29]="AUTH_I****"
I [25/Dec/2021:10:00:33 +0800] [Job 240] Started filter /usr/lib/cups/filter/pdftopdf (PID 5268)
I [25/Dec/2021:10:00:33 +0800] [Job 240] Started filter /usr/lib/cups/filter/gstoraster (PID 5269)
I [25/Dec/2021:10:00:33 +0800] [Job 240] Started filter /usr/lib/cups/filter/rastertokpsl-fixed (PID 5270)
I [25/Dec/2021:10:00:33 +0800] [Job 240] Started backend /usr/lib/cups/backend/usb (PID 5271)
D [25/Dec/2021:10:00:33 +0800] Discarding unused job-state-changed event...
D [25/Dec/2021:10:00:33 +0800] [Client 1] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/Kyocera_FS-1040) from localhost.
D [25/Dec/2021:10:00:33 +0800] [Client 1] Content-Length: 171
D [25/Dec/2021:10:00:33 +0800] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Dec/2021:10:00:33 +0800] [Client 1] con->http=0x55f05d2cf5e0
D [25/Dec/2021:10:00:33 +0800] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=171, response=0x55f05d2aca80(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Dec/2021:10:00:33 +0800] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Dec/2021:10:00:33 +0800] [Client 1] bytes=0, http_state=0, data_remaining=171
D [25/Dec/2021:10:00:33 +0800] [Client 1] Flushing write buffer.
D [25/Dec/2021:10:00:33 +0800] [Client 1] New state is HTTP_STATE_WAITING
D [25/Dec/2021:10:00:33 +0800] [Client 1] Waiting for request.
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files"
D [25/Dec/2021:10:00:33 +0800] [Client 1] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [25/Dec/2021:10:00:33 +0800] [Client 1] Closing connection.
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Dec/2021:10:00:33 +0800] [Job 240] Loading USB quirks from \"/usr/share/cups/usb\".
D [25/Dec/2021:10:00:33 +0800] [Job 240] Loaded 118 quirks.
D [25/Dec/2021:10:00:33 +0800] [Job 240] OUTFORMAT=\"<none>\", so output format will be CUPS/PWG Raster
D [25/Dec/2021:10:00:33 +0800] [Job 240] Printing on printer with URI: usb://Kyocera/FS-1040?serial=V246501534
D [25/Dec/2021:10:00:33 +0800] [Job 240] pdftopdf: Last filter determined by the PPD: rastertokpsl-fixed; FINAL_CONTENT_TYPE: application/vnd.cups-raster => pdftopdf will not log pages in page_log.
D [25/Dec/2021:10:00:33 +0800] [Job 240] PDF interactive form and annotation flattening done via QPDF
D [25/Dec/2021:10:00:33 +0800] [Job 240] libusb_get_device_list=9
D [25/Dec/2021:10:00:33 +0800] [Job 240] STATE: +connecting-to-device
D [25/Dec/2021:10:00:33 +0800] cupsdMarkDirty(---J-)
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [25/Dec/2021:10:00:33 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:33 +0800] [Job 240] STATE: -connecting-to-device
D [25/Dec/2021:10:00:33 +0800] cupsdMarkDirty(---J-)
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [25/Dec/2021:10:00:33 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:33 +0800] [Job 240] Color Manager: Calibration Mode/Off
D [25/Dec/2021:10:00:33 +0800] [Job 240] Device protocol: 2
D [25/Dec/2021:10:00:33 +0800] [Job 240] Calling FindDeviceById(cups-Kyocera_FS-1040)
D [25/Dec/2021:10:00:33 +0800] [Job 240] Failed to send: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [25/Dec/2021:10:00:33 +0800] [Job 240] Failed to get find device cups-Kyocera_FS-1040
D [25/Dec/2021:10:00:33 +0800] [Job 240] Calling FindDeviceById(cups-Kyocera_FS-1040)
D [25/Dec/2021:10:00:33 +0800] [Job 240] Failed to send: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [25/Dec/2021:10:00:33 +0800] [Job 240] Failed to get device cups-Kyocera_FS-1040
D [25/Dec/2021:10:00:33 +0800] [Job 240] Color Manager: no profiles specified in PPD
D [25/Dec/2021:10:00:33 +0800] cupsdMarkDirty(---J-)
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Dec/2021:10:00:33 +0800] [Job 240] Set job-printer-state-message to "Color Manager: no profiles specified in PPD", current level=INFO
D [25/Dec/2021:10:00:33 +0800] [Job 240] Color Manager: ICC Profile: None
D [25/Dec/2021:10:00:33 +0800] [Job 240] Ghostscript using Any-Part-of-Pixel method to fill paths.
D [25/Dec/2021:10:00:33 +0800] [Job 240] Ghostscript command line: gs -dQUIET -dSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -dShowAcroForm -sstdout=%stderr -sOutputFile=%stdout -sDEVICE=cups -r600x600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -dcupsBitsPerColor=8 -dcupsColorOrder=0 -dcupsColorSpace=3 -dcupsCompression=1 -scupsPageSizeName=A4 -I/usr/share/cups/fonts -c \'<</.HWMargins[12.000000 10.000000 12.000000 10.000000] /Margins[0 0]>>setpagedevice\' -f -_
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[0]=\"CUPS_CACHEDIR=/var/cache/cups\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[1]=\"CUPS_DATADIR=/usr/share/cups\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[2]=\"CUPS_DOCROOT=/usr/share/cups/doc\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[3]=\"CUPS_REQUESTROOT=/var/spool/cups\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[4]=\"CUPS_SERVERBIN=/usr/lib/cups\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[5]=\"CUPS_SERVERROOT=/etc/cups\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[6]=\"CUPS_STATEDIR=/run/cups\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[7]=\"HOME=/var/spool/cups/tmp\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[8]=\"PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[9]=\"SERVER_ADMIN=root@k55vddream\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[10]=\"SOFTWARE=CUPS/2.4.0\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[11]=\"TMPDIR=/var/spool/cups/tmp\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[12]=\"USER=root\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[13]=\"CUPS_MAX_MESSAGE=2047\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[14]=\"CUPS_SERVER=/run/cups/cups.sock\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[15]=\"CUPS_ENCRYPTION=IfRequested\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[16]=\"IPP_PORT=631\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[17]=\"CHARSET=utf-8\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[18]=\"LANG=en_US.UTF-8\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[19]=\"PPD=/etc/cups/ppd/Kyocera_FS-1040.ppd\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[20]=\"\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[21]=\"CONTENT_TYPE=application/pdf\"
D [25/Dec/2021:10:00:33 +0800] Discarding unused job-progress event...
D [25/Dec/2021:10:00:33 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:33 +0800] [Job 240] PID 5268 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[22]=\"DEVICE_URI=usb://Kyocera/FS-1040?serial=V246501534\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[23]=\"PRINTER_INFO=Kyocera FS-1040\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[24]=\"PRINTER_LOCATION=d1-10\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[25]=\"PRINTER=Kyocera_FS-1040\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[26]=\"PRINTER_STATE_REASONS=none\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[27]=\"CUPS_FILETYPE=document\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[28]=\"FINAL_CONTENT_TYPE=application/vnd.cups-raster\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] envp[29]=\"AUTH_INFO_REQUIRED=none\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] Sending data to printer.
D [25/Dec/2021:10:00:33 +0800] cupsdMarkDirty(---J-)
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Dec/2021:10:00:33 +0800] [Job 240] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [25/Dec/2021:10:00:33 +0800] Discarding unused job-progress event...
D [25/Dec/2021:10:00:33 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:33 +0800] [Job 240] Start rendering...
D [25/Dec/2021:10:00:33 +0800] cupsdMarkDirty(---J-)
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Dec/2021:10:00:33 +0800] [Job 240] Set job-printer-state-message to "Start rendering...", current level=INFO
D [25/Dec/2021:10:00:33 +0800] [Job 240] Processing page 1...
D [25/Dec/2021:10:00:33 +0800] cupsdMarkDirty(---J-)
D [25/Dec/2021:10:00:33 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Dec/2021:10:00:33 +0800] [Job 240] Set job-printer-state-message to "Processing page 1...", current level=INFO
D [25/Dec/2021:10:00:33 +0800] Discarding unused job-progress event...
D [25/Dec/2021:10:00:33 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:33 +0800] [Job 240] /usr/lib/cups/filter/rastertokpsl-fixed: line 4:  5289 Segmentation fault      (core dumped) $path/rastertokpsl \"$1\" \"$2\" \"$jobname\" \"$4\" \"$5\"
D [25/Dec/2021:10:00:33 +0800] [Job 240] Sent 0 bytes...
D [25/Dec/2021:10:00:33 +0800] [Job 240] PID 5270 (/usr/lib/cups/filter/rastertokpsl-fixed) stopped with status 139 (Directory not empty)
D [25/Dec/2021:10:00:33 +0800] [Job 240] Processing page 2...
D [25/Dec/2021:10:00:33 +0800] Discarding unused job-progress event...
D [25/Dec/2021:10:00:33 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:34 +0800] [Job 240] Processing page 3...
D [25/Dec/2021:10:00:34 +0800] Discarding unused job-progress event...
D [25/Dec/2021:10:00:34 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:34 +0800] [Job 240] Processing page 4...
D [25/Dec/2021:10:00:34 +0800] Discarding unused job-progress event...
D [25/Dec/2021:10:00:34 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:34 +0800] [Job 240] Processing page 5...
D [25/Dec/2021:10:00:34 +0800] Discarding unused job-progress event...
D [25/Dec/2021:10:00:34 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:34 +0800] [Job 240] Processing page 6...
D [25/Dec/2021:10:00:34 +0800] Discarding unused job-progress event...
D [25/Dec/2021:10:00:34 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:34 +0800] [Job 240] Rendering completed
D [25/Dec/2021:10:00:34 +0800] Discarding unused job-progress event...
D [25/Dec/2021:10:00:34 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:34 +0800] [Job 240] PID 5269 (/usr/lib/cups/filter/gstoraster) exited with no errors.
D [25/Dec/2021:10:00:34 +0800] [Job 240] Waiting for read thread to exit...
D [25/Dec/2021:10:00:34 +0800] [Job 240] PID 5271 (/usr/lib/cups/backend/usb) exited with no errors.
D [25/Dec/2021:10:00:34 +0800] Discarding unused job-state-changed event...
E [25/Dec/2021:10:00:34 +0800] [Job 240] Job stopped due to filter errors; please consult the /var/log/cups/error_log file for details.
D [25/Dec/2021:10:00:34 +0800] cupsdMarkDirty(---J-)
D [25/Dec/2021:10:00:34 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Dec/2021:10:00:34 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Dec/2021:10:00:34 +0800] Discarding unused printer-state-changed event...
D [25/Dec/2021:10:00:34 +0800] [Job 240] The following messages were recorded from 10:00:33 to 10:00:33
D [25/Dec/2021:10:00:34 +0800] [Job 240] iSerialNumber=\"V246501534\"
D [25/Dec/2021:10:00:34 +0800] [Job 240] Printer found with device ID: MFG:Kyocera;MDL:FS-1040;CLS:PRINTER;SN:V246501534;CID:KY_KPSL_MonoPersonal; Device URI: usb://Kyocera/FS-1040?serial=V246501534
D [25/Dec/2021:10:00:34 +0800] [Job 240] End of messages
D [25/Dec/2021:10:00:34 +0800] [Job 240] printer-state=3(idle)
D [25/Dec/2021:10:00:34 +0800] [Job 240] printer-state-message="Rendering completed"
D [25/Dec/2021:10:00:34 +0800] [Job 240] printer-state-reasons=none
D [25/Dec/2021:10:00:35 +0800] [Job 240] Unloading...

pls help!!!

Last edited by igronin (2021-12-25 12:37:11)

Offline

#2 2021-12-25 08:08:48

seth
Member
Registered: 2012-09-03
Posts: 49,998

Re: CUPS - Filter failed after - yay -Syu

pls wrp tht n cd tgs!!!
https://bbs.archlinux.org/help.php#bbcode


D [25/Dec/2021:10:00:33 +0800] [Job 240] /usr/lib/cups/filter/rastertokpsl-fixed: line 4:  5289 Segmentation fault      (core dumped) $path/rastertokpsl \"$1\" \"$2\" \"$jobname\" \"$4\" \"$5\"

https://wiki.archlinux.org/title/Core_dump

As "rastertokpsl" doesn't seem to be provided by a repo package, did you update the AUR package that likely provides the printer driver? And which is it to begin with?

Online

#3 2021-12-25 14:08:04

igronin
Member
Registered: 2021-12-25
Posts: 4

Re: CUPS - Filter failed after - yay -Syu

seth wrote:

pls wrp tht n cd tgs!!!
https://bbs.archlinux.org/help.php#bbcode


D [25/Dec/2021:10:00:33 +0800] [Job 240] /usr/lib/cups/filter/rastertokpsl-fixed: line 4:  5289 Segmentation fault      (core dumped) $path/rastertokpsl \"$1\" \"$2\" \"$jobname\" \"$4\" \"$5\"

https://wiki.archlinux.org/title/Core_dump

As "rastertokpsl" doesn't seem to be provided by a repo package, did you update the AUR package that likely provides the printer driver? And which is it to begin with?

Thanks
I tried update all.
rastertokpsl has no updates

           PID: 460063 (rastertokpsl)
           UID: 209 (cups)
           GID: 209 (cups)
        Signal: 11 (SEGV)
     Timestamp: Fri 2021-12-24 16:31:50 WITA (1 day 5h ago)
  Command Line: /usr/lib/cups/filter/rastertokpsl 228 ihar f24denppdf 1 $'finishings=3 number-up=1 job-uuid=urn:uuid:663341c1-59c2-3bcc-4bbe-f980ea77d921 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1640334710 time-at-processing=1640334710 document-name-supplied=f24_denp.pdf'
    Executable: /usr/lib/cups/filter/rastertokpsl
 Control Group: /system.slice/cups.service
          Unit: cups.service
         Slice: system.slice
       Boot ID: 72d60e6a47814a5fa6935b120d1b3298
    Machine ID: b3ad6aad9b724b1fb0c117c0210d3011
      Hostname: k55vddream
       Storage: /var/lib/systemd/coredump/core.rastertokpsl.209.72d60e6a47814a5fa6935b120d1b3298.460063.1640334710000000.zst (inaccessible)
       Message: Process 460063 (rastertokpsl) of user 209 dumped core.

                Found module linux-vdso.so.1 with build-id: 34ce7d9e9e52decbbe2ad4dbbb77e7b72d5f56c6
                Found module libgpg-error.so.0 with build-id: 3801187d42c4955bd93c605451430cdf1b164e63
                Found module libgcrypt.so.20 with build-id: db45f5d5e0f7af1e77324fea1885f974619ad268
                Found module libcap.so.2 with build-id: f56c6cd6ad4d35053340d7ff2f8f954498796739
                Found module liblz4.so.1 with build-id: e63600ab23b2f6997f42fac2fa56e1f02ce159a1
                Found module libzstd.so.1 with build-id: 4b10444c1560ebc574af4d5f488b7408b22d450e
                Found module liblzma.so.5 with build-id: 8b615460aa230708c5183f16bede67aa0437d95e
                Found module librt.so.1 with build-id: 75484da2d6f1515189eefa076e0a40328834cd16
                Found module libffi.so.8 with build-id: f90d8b734f6de9b25faedb8cbfab7054dafc0a42
                Found module libsystemd.so.0 with build-id: efcf1b39ffd5f65334b94df717072c7e7a1b5fa0
                Found module libgmp.so.10 with build-id: e58d34ab389d1b649c24195c2d145e3ff2e58290
                Found module libhogweed.so.6 with build-id: 2d70cff7b1841b4d9ca4e8e7726cd4b944c07fdc
                Found module libnettle.so.8 with build-id: 9a878e513c02007598fcf1e2e286c2203f13536e
                Found module libtasn1.so.6 with build-id: ee3429ca5e94718aea4fe5249fc859e0cd88e4e9
                Found module libunistring.so.2 with build-id: 015ac6d6bcb60b7d8bea31a80d1941b06e8636ab
                Found module libidn2.so.0 with build-id: 1ce2b50ad9f9821c2c629b521cf5a3c99593d332
                Found module libp11-kit.so.0 with build-id: f97c44b297b54185bbe3eb6ed6dab5d8967f1532
                Found module libdl.so.2 with build-id: 5abc547e7b0949f89f3c0e21ab0c8331a7440a8a
                Found module libdbus-1.so.3 with build-id: 74f2ab9c60512f3a93c932c3f627564d42e0b11e
                Found module libz.so.1 with build-id: 81bf6e728a6d6f5b105b0f8b25f6c614ce10452a
                Found module libgnutls.so.30 with build-id: 8c87466eacaec0041a370df713d0fd200358c94c
                Found module libavahi-client.so.3 with build-id: 1858551543958190c653b565cf0eb64609ad908a
                Found module libavahi-common.so.3 with build-id: 80fda945459a3476ccd1050783dfd5f5c17c479a
                Found module ld-linux-x86-64.so.2 with build-id: 040cc3dd10461562f177df39e3be2f3704258c3c
                Found module libcups.so.2 with build-id: 68a2ef2ccefd545e68b78c5acb20bcb2818c5049
                Found module libpthread.so.0 with build-id: 07c8f95b4f3251d08550217ad8a1f31066229996
                Found module libc.so.6 with build-id: 4b406737057708c0e4c642345a703c47a61c73dc
                Found module libm.so.6 with build-id: 2b8fd1f869ecab4e0b55e92f2f151897f6818acf
                Found module libcupsimage.so.2 with build-id: 6b57b15e1f3ef3005cafa364f1f6824bb6151a5e
                Found module rastertokpsl with build-id: a70034810f588365fa28d7d646060d2830465b58
                Stack trace of thread 460063:
                #0  0x00007fdec15297ca _cupsRasterClearError (libcups.so.2 + 0x477ca)
                #1  0x00007fdec152a9bc _cupsRasterNew (libcups.so.2 + 0x489bc)
                #2  0x0000000000406cdf n/a (rastertokpsl + 0x6cdf)
                #3  0x00007fdec15c7b25 __libc_start_main (libc.so.6 + 0x27b25)
                #4  0x000000000040799d n/a (rastertokpsl + 0x799d)

in core dump I can see,

Type "apropos word" to search for commands related to "word"...
Reading symbols from /usr/lib/cups/filter/rastertokpsl...
(No debugging symbols found in /usr/lib/cups/filter/rastertokpsl)
[New LWP 460063]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/usr/lib/libthread_db.so.1".
Core was generated by `/usr/lib/cups/filter/rastertokpsl 228 ihar f24denppdf 1 finishings=3 number-up='.
Program terminated with signal SIGSEGV, Segmentation fault.
#0  0x00007fdec15297ca in _cupsRasterClearError () from /usr/lib/libcups.so.2
(gdb) bt
#0  0x00007fdec15297ca in _cupsRasterClearError () from /usr/lib/libcups.so.2
#1  0x00007fdec152a9bc in _cupsRasterNew () from /usr/lib/libcups.so.2
#2  0x0000000000406cdf in ?? ()
#3  0x00007fdec15c7b25 in __libc_start_main () from /usr/lib/libc.so.6
#4  0x000000000040799d in ?? ()
#5  0x00007ffcb0a02268 in ?? ()
#6  0x000000000000001c in ?? ()
#7  0x0000000000000006 in ?? ()
#8  0x00007ffcb0a03b3c in ?? ()
#9  0x00007ffcb0a03b5e in ?? ()
#10 0x00007ffcb0a03b62 in ?? ()
#11 0x00007ffcb0a03b67 in ?? ()
#12 0x00007ffcb0a03b72 in ?? ()
#13 0x00007ffcb0a03b74 in ?? ()
#14 0x0000000000000000 in ?? ()

I used downgrade to switch on previous version of cups but is didnt help.
any adeas?

Last edited by igronin (2021-12-25 14:10:39)

Offline

#4 2021-12-25 14:46:55

loqs
Member
Registered: 2014-03-06
Posts: 17,196

Re: CUPS - Filter failed after - yay -Syu

Offline

#5 2021-12-25 19:00:54

seth
Member
Registered: 2012-09-03
Posts: 49,998

Re: CUPS - Filter failed after - yay -Syu

That package seems to be some 7 year old binary release…
The critical update was likely https://archlinux.org/packages/extra/x86_64/libcups/

Online

#6 2021-12-25 19:59:02

progandy
Member
Registered: 2012-05-17
Posts: 5,184

Re: CUPS - Filter failed after - yay -Syu

seth wrote:

That package seems to be some 7 year old binary release…
The critical update was likely https://archlinux.org/packages/extra/x86_64/libcups/

An alternative may be https://aur.archlinux.org/packages/kyocera-ppd-git/ (probably too old as well)

Otherwise maybe you can try to compile and maybe fix https://github.com/sv99/rastertokpsl-re
Edit: there are two forks that seem to add support for building on linux: https://github.com/Fe-Ti/rastertokpsl-re or https://github.com/jollheef/rastertokpsl-re

Last edited by progandy (2021-12-25 20:05:11)


| alias CUTF='LANG=en_XX.UTF-8@POSIX ' |

Offline

#7 2021-12-26 01:04:44

igronin
Member
Registered: 2021-12-25
Posts: 4

Re: CUPS - Filter failed after - yay -Syu

BIG thanks to all wizards here!!!

I really used https://aur.archlinux.org/packages/rast … l-fs-1040/

switch to https://github.com/Fe-Ti/rastertokpsl-re
totally solved the problem!

Offline

#8 2021-12-26 08:52:19

seth
Member
Registered: 2012-09-03
Posts: 49,998

Re: CUPS - Filter failed after - yay -Syu

Please always remember to mark resolved threads by editing your initial posts subject - so others will know that there's no task left, but maybe a solution to find.
Thanks.

Online

Board footer

Powered by FluxBB