When I do 'hp-testpage -i', I get the following error_log.txt:
Code: Select all
I [06/Dec/2018:19:44:41 +0100] Saving job.cache...
I [06/Dec/2018:19:44:41 +0100] Saving subscriptions.conf...
D [06/Dec/2018:19:44:41 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [06/Dec/2018:19:44:41 +0100] Creating keep-alive file "/var/cache/cups/org.cups.cupsd".
I [06/Dec/2018:19:44:41 +0100] Saving job.cache...
D [06/Dec/2018:19:44:41 +0100] [Job 14] Unloading...
D [06/Dec/2018:19:44:41 +0100] cupsdStopSelect()
I [06/Dec/2018:19:44:59 +0100] Listening to [v1.::1]:631 (IPv6)
I [06/Dec/2018:19:44:59 +0100] Listening to 127.0.0.1:631 (IPv4)
I [06/Dec/2018:19:44:59 +0100] Listening to /var/run/cups/cups.sock (Domain)
I [06/Dec/2018:19:44:59 +0100] Remote access is disabled.
D [06/Dec/2018:19:44:59 +0100] Added auto ServerAlias runs-PC
I [06/Dec/2018:19:44:59 +0100] Loaded configuration file "/etc/cups/cupsd.conf"
D [06/Dec/2018:19:44:59 +0100] Using keychain "/etc/cups/ssl" for server name "runs-PC".
I [06/Dec/2018:19:44:59 +0100] Using default TempDir of /var/spool/cups/tmp...
I [06/Dec/2018:19:44:59 +0100] Configured for up to 100 clients.
I [06/Dec/2018:19:44:59 +0100] Allowing up to 100 client connections per host.
I [06/Dec/2018:19:44:59 +0100] Using policy "default" as the default.
I [06/Dec/2018:19:44:59 +0100] Full reload is required.
I [06/Dec/2018:19:44:59 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 49 types, 84 filters...
D [06/Dec/2018:19:44:59 +0100] Loading printer HP-LaserJet-Professional-P1102...
D [06/Dec/2018:19:44:59 +0100] load_ppd: Loading /var/cache/cups/HP-LaserJet-Professional-P1102.data...
D [06/Dec/2018:19:44:59 +0100] cupsdRegisterPrinter(p=0x5630b1cab770(HP-LaserJet-Professional-P1102))
I [06/Dec/2018:19:44:59 +0100] Loading job cache file "/var/cache/cups/job.cache"...
D [06/Dec/2018:19:44:59 +0100] [Job 14] Loading from cache...
D [06/Dec/2018:19:44:59 +0100] [Job 15] Loading from cache...
D [06/Dec/2018:19:44:59 +0100] [Job 16] Loading from cache...
D [06/Dec/2018:19:44:59 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [06/Dec/2018:19:44:59 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [06/Dec/2018:19:44:59 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [06/Dec/2018:19:44:59 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [06/Dec/2018:19:44:59 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [06/Dec/2018:19:44:59 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [06/Dec/2018:19:44:59 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [06/Dec/2018:19:44:59 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [06/Dec/2018:19:44:59 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [06/Dec/2018:19:44:59 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
I [06/Dec/2018:19:44:59 +0100] Full reload complete.
D [06/Dec/2018:19:44:59 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [06/Dec/2018:19:44:59 +0100] Cleaning out old files in "/var/spool/cups/tmp".
D [06/Dec/2018:19:44:59 +0100] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
I [06/Dec/2018:19:44:59 +0100] Cleaning out old files in "/var/cache/cups".
D [06/Dec/2018:19:44:59 +0100] service_checkin: pid=2761
D [06/Dec/2018:19:44:59 +0100] service_checkin: 1 listeners.
D [06/Dec/2018:19:44:59 +0100] service_add_listener: Listener #1 at fd 3, "/var/run/cups/cups.sock".
D [06/Dec/2018:19:44:59 +0100] service_add_listener: Matched existing listener #1 to /var/run/cups/cups.sock.
D [06/Dec/2018:19:44:59 +0100] Creating keep-alive file "/var/cache/cups/org.cups.cupsd".
D [06/Dec/2018:19:44:59 +0100] Calling FindDeviceById(cups-HP-LaserJet-Professional-P1102)
D [06/Dec/2018:19:44:59 +0100] FindDeviceById failed: org.freedesktop.ColorManager.NotFound:device id \'cups-HP-LaserJet-Professional-P1102\' does not exist
D [06/Dec/2018:19:44:59 +0100] Using profile ID "HP-LaserJet-Professional-P1102-Gray..".
D [06/Dec/2018:19:44:59 +0100] Calling CreateProfile(HP-LaserJet-Professional-P1102-Gray..,temp)
D [06/Dec/2018:19:44:59 +0100] Created profile "/org/freedesktop/ColorManager/profiles/HP_LaserJet_Professional_P1102_Gray__".
D [06/Dec/2018:19:44:59 +0100] Using profile ID "HP-LaserJet-Professional-P1102-RGB..".
D [06/Dec/2018:19:44:59 +0100] Calling CreateProfile(HP-LaserJet-Professional-P1102-RGB..,temp)
D [06/Dec/2018:19:45:00 +0100] Created profile "/org/freedesktop/ColorManager/profiles/HP_LaserJet_Professional_P1102_RGB__".
I [06/Dec/2018:19:45:00 +0100] Registering ICC color profiles for "HP-LaserJet-Professional-P1102".
D [06/Dec/2018:19:45:00 +0100] Calling CreateDevice(cups-HP-LaserJet-Professional-P1102,temp)
D [06/Dec/2018:19:45:00 +0100] Created device "/org/freedesktop/ColorManager/devices/cups_HP_LaserJet_Professional_P1102".
D [06/Dec/2018:19:45:00 +0100] Calling /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_Professional_P1102:AddProfile(/org/freedesktop/ColorManager/profiles/HP_LaserJet_Professional_P1102_Gray__) [soft]
D [06/Dec/2018:19:45:00 +0100] Calling /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_Professional_P1102:AddProfile(/org/freedesktop/ColorManager/profiles/HP_LaserJet_Professional_P1102_RGB__) [soft]
I [06/Dec/2018:19:45:00 +0100] Listening to [v1.::1]:631 on fd 9...
I [06/Dec/2018:19:45:00 +0100] Listening to 127.0.0.1:631 on fd 10...
I [06/Dec/2018:19:45:00 +0100] Listening to /var/run/cups/cups.sock on fd 3...
I [06/Dec/2018:19:45:00 +0100] Resuming new connection processing...
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [06/Dec/2018:19:45:00 +0100] cupsdAddCert: Adding certificate for PID 0
D [06/Dec/2018:19:45:00 +0100] Notifier dbus started - PID = 2767
D [06/Dec/2018:19:45:00 +0100] cupsdMarkDirty(----S)
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Not busy"
D [06/Dec/2018:19:45:00 +0100] [Client 1] Server address is "/var/run/cups/cups.sock".
D [06/Dec/2018:19:45:00 +0100] [Client 1] Accepted from localhost (Domain)
D [06/Dec/2018:19:45:00 +0100] [Client 1] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] Report: clients=1
D [06/Dec/2018:19:45:00 +0100] Report: jobs=3
D [06/Dec/2018:19:45:00 +0100] Report: jobs-active=0
D [06/Dec/2018:19:45:00 +0100] Report: printers=1
D [06/Dec/2018:19:45:00 +0100] Report: stringpool-string-count=1042
D [06/Dec/2018:19:45:00 +0100] Report: stringpool-alloc-bytes=8232
D [06/Dec/2018:19:45:00 +0100] Report: stringpool-total-bytes=19384
D [06/Dec/2018:19:45:00 +0100] [Client 1] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 1] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 1] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 1] 2.0 CUPS-Get-Printers 1
D [06/Dec/2018:19:45:00 +0100] CUPS-Get-Printers
D [06/Dec/2018:19:45:00 +0100] [Client 1] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 1] Content-Length: 531
D [06/Dec/2018:19:45:00 +0100] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 1] con->http=0x5630b1d34e00
D [06/Dec/2018:19:45:00 +0100] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=531, response=0x5630b1d26520(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 1] bytes=0, http_state=0, data_remaining=531
D [06/Dec/2018:19:45:00 +0100] [Client 1] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 1] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 1] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Notifier] state=3
D [06/Dec/2018:19:45:00 +0100] [Notifier] Connected to D-BUS
D [06/Dec/2018:19:45:00 +0100] [Notifier] ServerStarted
D [06/Dec/2018:19:45:00 +0100] [Client 1] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 1] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 1] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 1] 2.0 CUPS-Get-Printers 2
D [06/Dec/2018:19:45:00 +0100] CUPS-Get-Printers
D [06/Dec/2018:19:45:00 +0100] [Client 1] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 1] Content-Length: 531
D [06/Dec/2018:19:45:00 +0100] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 1] con->http=0x5630b1d34e00
D [06/Dec/2018:19:45:00 +0100] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=531, response=0x5630b1d30060(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 1] bytes=0, http_state=0, data_remaining=531
D [06/Dec/2018:19:45:00 +0100] [Client 1] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 1] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 1] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 1] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 1] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 1] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 1] 2.0 CUPS-Get-Printers 3
D [06/Dec/2018:19:45:00 +0100] CUPS-Get-Printers
D [06/Dec/2018:19:45:00 +0100] [Client 1] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 1] Content-Length: 531
D [06/Dec/2018:19:45:00 +0100] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 1] con->http=0x5630b1d34e00
D [06/Dec/2018:19:45:00 +0100] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=531, response=0x5630b1d262f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 1] bytes=0, http_state=0, data_remaining=531
D [06/Dec/2018:19:45:00 +0100] [Client 1] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 1] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 1] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 1] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 1] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 1] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 1] 2.0 CUPS-Get-Printers 4
D [06/Dec/2018:19:45:00 +0100] CUPS-Get-Printers
D [06/Dec/2018:19:45:00 +0100] [Client 1] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 1] Content-Length: 531
D [06/Dec/2018:19:45:00 +0100] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 1] con->http=0x5630b1d34e00
D [06/Dec/2018:19:45:00 +0100] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=531, response=0x5630b1d26520(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 1] bytes=0, http_state=0, data_remaining=531
D [06/Dec/2018:19:45:00 +0100] [Client 1] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 1] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 1] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 2] Server address is "/var/run/cups/cups.sock".
D [06/Dec/2018:19:45:00 +0100] [Client 2] Accepted from localhost (Domain)
D [06/Dec/2018:19:45:00 +0100] [Client 2] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] [Client 2] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 2] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 2] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 2] 2.0 Get-Printer-Attributes 1
D [06/Dec/2018:19:45:00 +0100] Get-Printer-Attributes ipp://localhost:631/printers/HP-LaserJet-Professional-P1102
D [06/Dec/2018:19:45:00 +0100] [Client 2] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/HP-LaserJet-Professional-P1102) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 2] Content-Length: 1269
D [06/Dec/2018:19:45:00 +0100] [Client 2] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 2] con->http=0x5630b1d391d0
D [06/Dec/2018:19:45:00 +0100] [Client 2] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1269, response=0x5630b1d30db0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 2] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 2] bytes=0, http_state=0, data_remaining=1269
D [06/Dec/2018:19:45:00 +0100] [Client 2] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 2] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 2] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 2] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [06/Dec/2018:19:45:00 +0100] [Client 2] Closing connection.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 3] Server address is "/var/run/cups/cups.sock".
D [06/Dec/2018:19:45:00 +0100] [Client 3] Accepted from localhost (Domain)
D [06/Dec/2018:19:45:00 +0100] [Client 3] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] [Client 3] POST /printers/HP-LaserJet-Professional-P1102 HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 3] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 3] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 3] 2.0 Create-Job 2
D [06/Dec/2018:19:45:00 +0100] Create-Job ipp://localhost:631/printers/HP-LaserJet-Professional-P1102
D [06/Dec/2018:19:45:00 +0100] cupsdMarkDirty(---J-)
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] add_job: requesting-user-name="runs"
I [06/Dec/2018:19:45:00 +0100] [Job 17] Adding start banner page "none".
D [06/Dec/2018:19:45:00 +0100] cupsdMarkDirty(----S)
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [06/Dec/2018:19:45:00 +0100] [Job 17] Queued on "HP-LaserJet-Professional-P1102" by "runs".
D [06/Dec/2018:19:45:00 +0100] [Client 3] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/HP-LaserJet-Professional-P1102) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 3] Content-Length: 200
D [06/Dec/2018:19:45:00 +0100] [Client 3] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 3] con->http=0x5630b1d391d0
D [06/Dec/2018:19:45:00 +0100] [Client 3] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=200, response=0x5630b1d2c330(IPP_STATE_IDLE), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 3] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 3] bytes=0, http_state=0, data_remaining=200
D [06/Dec/2018:19:45:00 +0100] [Client 3] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 3] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 3] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Notifier] state=3
D [06/Dec/2018:19:45:00 +0100] [Notifier] JobCreated
D [06/Dec/2018:19:45:00 +0100] [Client 3] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [06/Dec/2018:19:45:00 +0100] [Client 3] Closing connection.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 4] Server address is "/var/run/cups/cups.sock".
D [06/Dec/2018:19:45:00 +0100] [Client 4] Accepted from localhost (Domain)
D [06/Dec/2018:19:45:00 +0100] [Client 4] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] [Client 4] POST /printers/HP-LaserJet-Professional-P1102 HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 4] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 4] 2.0 Send-Document 3
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] [Client 4] Read: status=100
D [06/Dec/2018:19:45:00 +0100] Send-Document ipp://localhost:631/printers/HP-LaserJet-Professional-P1102
D [06/Dec/2018:19:45:00 +0100] cupsdIsAuthorized: requesting-user-name="runs"
D [06/Dec/2018:19:45:00 +0100] [Job 17] Auto-typing file...
D [06/Dec/2018:19:45:00 +0100] [Job 17] Request file type is application/postscript.
D [06/Dec/2018:19:45:00 +0100] cupsdMarkDirty(---J-)
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [06/Dec/2018:19:45:00 +0100] [Job 17] File of type application/postscript queued by "runs".
I [06/Dec/2018:19:45:00 +0100] [Job 17] Adding end banner page "none".
D [06/Dec/2018:19:45:00 +0100] cupsdMarkDirty(---J-)
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Job 17] time-at-processing=1544121900
D [06/Dec/2018:19:45:00 +0100] cupsdMarkDirty(---J-)
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] cupsdMarkDirty(----S)
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Job 17] 4 filters for job:
D [06/Dec/2018:19:45:00 +0100] [Job 17] gstopdf (application/postscript to application/pdf, cost 0)
D [06/Dec/2018:19:45:00 +0100] [Job 17] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [06/Dec/2018:19:45:00 +0100] [Job 17] gstoraster (application/vnd.cups-pdf to application/vnd.cups-raster, cost 99)
D [06/Dec/2018:19:45:00 +0100] [Job 17] hpcups (application/vnd.cups-raster to printer/HP-LaserJet-Professional-P1102, cost 0)
D [06/Dec/2018:19:45:00 +0100] [Job 17] job-sheets=none,none
D [06/Dec/2018:19:45:00 +0100] [Job 17] argv[0]="HP-LaserJet-Professional-P1102"
D [06/Dec/2018:19:45:00 +0100] [Job 17] argv[1]="17"
D [06/Dec/2018:19:45:00 +0100] [Job 17] argv[2]="runs"
D [06/Dec/2018:19:45:00 +0100] [Job 17] argv[3]="tmpngutc6og"
D [06/Dec/2018:19:45:00 +0100] [Job 17] argv[4]="1"
D [06/Dec/2018:19:45:00 +0100] [Job 17] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:fdc25cdd-6cf6-399b-5fb0-634aae7b9422 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1544121900 time-at-processing=1544121900 document-name-supplied=tmpngutc6og"
D [06/Dec/2018:19:45:00 +0100] [Job 17] argv[6]="/var/spool/cups/d00017-001"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[8]="HOME=/var/spool/cups/tmp"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[10]="SERVER_ADMIN=root@runs-PC"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[11]="SOFTWARE=CUPS/2.2.1"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[13]="USER=root"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[14]="CUPS_MAX_MESSAGE=2047"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[17]="IPP_PORT=631"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[18]="CHARSET=utf-8"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[19]="LANG=es_ES.UTF-8"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[20]="PPD=/etc/cups/ppd/HP-LaserJet-Professional-P1102.ppd"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[21]="RIP_MAX_CACHE=128m"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[22]="CONTENT_TYPE=application/postscript"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[23]="DEVICE_URI=hp:/usb/HP_LaserJet_Professional_P1102?serial=000000000Q80XBWWSI1c"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[24]="PRINTER_INFO=Hewlett-Packard HP LaserJet Professional P1102"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[25]="PRINTER_LOCATION=runs-PC"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[26]="PRINTER=HP-LaserJet-Professional-P1102"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[27]="PRINTER_STATE_REASONS=none"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[28]="CUPS_FILETYPE=document"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-raster"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[30]="AUTH_I****"
I [06/Dec/2018:19:45:00 +0100] [Job 17] Started filter /usr/lib/cups/filter/gstopdf (PID 2773)
I [06/Dec/2018:19:45:00 +0100] [Job 17] Started filter /usr/lib/cups/filter/pdftopdf (PID 2774)
I [06/Dec/2018:19:45:00 +0100] [Job 17] Started filter /usr/lib/cups/filter/gstoraster (PID 2775)
I [06/Dec/2018:19:45:00 +0100] [Job 17] Started filter /usr/lib/cups/filter/hpcups (PID 2776)
I [06/Dec/2018:19:45:00 +0100] [Job 17] Started backend /usr/lib/cups/backend/hp (PID 2777)
D [06/Dec/2018:19:45:00 +0100] cupsdMarkDirty(----S)
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 4] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/HP-LaserJet-Professional-P1102) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 4] Content-Length: 170
D [06/Dec/2018:19:45:00 +0100] [Client 4] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 4] con->http=0x5630b1d391d0
D [06/Dec/2018:19:45:00 +0100] [Client 4] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=170, response=0x5630b1d30a60(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 4] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 4] bytes=0, http_state=0, data_remaining=170
D [06/Dec/2018:19:45:00 +0100] [Client 4] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 4] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 4] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Notifier] state=3
D [06/Dec/2018:19:45:00 +0100] [Notifier] PrinterStateChanged
D [06/Dec/2018:19:45:00 +0100] [Notifier] state=3
D [06/Dec/2018:19:45:00 +0100] [Notifier] JobState
D [06/Dec/2018:19:45:00 +0100] [Job 17] gstopdf argv[6] = 17 runs tmpngutc6og 1 finishings=3 number-up=1 job-uuid=urn:uuid:fdc25cdd-6cf6-399b-5fb0-634aae7b9422 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1544121900 time-at-processing=1544121900 document-name-supplied=tmpngutc6og /var/spool/cups/d00017-001
D [06/Dec/2018:19:45:00 +0100] [Job 17] PPD: /etc/cups/ppd/HP-LaserJet-Professional-P1102.ppd
D [06/Dec/2018:19:45:00 +0100] [Client 4] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [06/Dec/2018:19:45:00 +0100] [Client 4] Closing connection.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Job 17] OUTFORMAT=\"(null)\", so output format will be CUPS/PWG Raster
D [06/Dec/2018:19:45:00 +0100] [Job 17] pdftopdf: Last filter determined by the PPD: hpcups; FINAL_CONTENT_TYPE: application/vnd.cups-raster => pdftopdf will not log pages in page_log.
D [06/Dec/2018:19:45:00 +0100] [Job 17] OUTFORMAT=\"PDF\", so output format will be PDF
D [06/Dec/2018:19:45:00 +0100] [Job 17] Color Manager: Calibration Mode/Off
D [06/Dec/2018:19:45:00 +0100] [Job 17] Calling FindDeviceById(cups-HP-LaserJet-Professional-P1102)
D [06/Dec/2018:19:45:00 +0100] [Job 17] Found device /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_Professional_P1102
D [06/Dec/2018:19:45:00 +0100] [Job 17] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors)
D [06/Dec/2018:19:45:00 +0100] [Job 17] Calling FindDeviceById(cups-HP-LaserJet-Professional-P1102)
D [06/Dec/2018:19:45:00 +0100] [Job 17] Found device /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_Professional_P1102
D [06/Dec/2018:19:45:00 +0100] [Job 17] Calling GetProfileForQualifiers(Gray.Plain....)
D [06/Dec/2018:19:45:00 +0100] [Job 17] Found profile /org/freedesktop/ColorManager/profiles/HP_LaserJet_Professional_P1102_Gray__
D [06/Dec/2018:19:45:00 +0100] [Job 17] Calling org.freedesktop.ColorManager.Profile.Get(Filename)
D [06/Dec/2018:19:45:00 +0100] [Job 17] Use profile filename: \'\'
D [06/Dec/2018:19:45:00 +0100] [Job 17] Color Manager: ICC Profile:
D [06/Dec/2018:19:45:00 +0100] [Job 17] Ghostscript using Any-Part-of-Pixel method to fill paths.
D [06/Dec/2018:19:45:00 +0100] [Job 17] Ghostscript command line: gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -sstdout=%stderr -sOutputFile=%stdout -sDEVICE=pdfwrite -dCompatibilityLevel=1.3 -dAutoRotatePages=/None -dAutoFilterColorImages=false -dNOPLATFONTS -dColorImageFilter=/FlateEncode -dPDFSETTINGS=/printer -dColorConversionStrategy=/LeaveColorUnchanged -r600x600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=841 -I/usr/share/cups/fonts -c \'<</.HWMargins[18.000000 15.500000 18.000000 15.500000] /Margins[0 0]>>setpagedevice\' -f -_
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[0]=\"CONTENT_TYPE=application/postscript\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[1]=\"PRINTER_INFO=Hewlett-Packard HP LaserJet Professional P1102\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[2]=\"USER=root\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[3]=\"CUPS_SERVER=/var/run/cups/cups.sock\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[4]=\"HOME=/var/spool/cups/tmp\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[5]=\"RIP_MAX_CACHE=128m\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[6]=\"CUPS_SERVERROOT=/etc/cups\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[7]=\"CUPS_CACHEDIR=/var/cache/cups\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[8]=\"PRINTER_STATE_REASONS=none\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[9]=\"CUPS_REQUESTROOT=/var/spool/cups\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[10]=\"OUTFORMAT=PDF\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[11]=\"PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[12]=\"DEVICE_URI=hp:/usb/HP_LaserJet_Professional_P1102?serial=000000000Q80XBWWSI1c\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[13]=\"CUPS_STATEDIR=/var/run/cups\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[14]=\"CUPS_MAX_MESSAGE=2047\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[15]=\"LANG=es_ES.UTF-8\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[16]=\"CUPS_SERVERBIN=/usr/lib/cups\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[17]=\"CUPS_FILETYPE=document\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[18]=\"PPD=/etc/cups/ppd/HP-LaserJet-Professional-P1102.ppd\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[19]=\"CUPS_FONTPATH=/usr/share/cups/fonts\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[20]=\"IPP_PORT=631\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[21]=\"AUTH_INFO_REQUIRED=none\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[22]=\"PRINTER_LOCATION=runs-PC\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[23]=\"CUPS_DOCROOT=/usr/share/cups/doc-root\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[24]=\"SERVER_ADMIN=root@runs-PC\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[25]=\"PWD=/\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[26]=\"CHARSET=utf-8\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[27]=\"PRINTER=HP-LaserJet-Professional-P1102\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[28]=\"SOFTWARE=CUPS/2.2.1\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[29]=\"CUPS_DATADIR=/usr/share/cups\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[30]=\"FINAL_CONTENT_TYPE=application/vnd.cups-raster\"
D [06/Dec/2018:19:45:00 +0100] [Job 17] envp[31]=\"CUPS_ENCRYPTION=IfRequested\"
D [06/Dec/2018:19:45:00 +0100] [Client 1] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [06/Dec/2018:19:45:00 +0100] [Client 1] Closing connection.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Job 17] gs: symbol lookup error: /usr/lib/x86_64-linux-gnu/libgs.so.9: undefined symbol: FT_Property_Set
D [06/Dec/2018:19:45:00 +0100] [Client 5] Server address is "/var/run/cups/cups.sock".
D [06/Dec/2018:19:45:00 +0100] [Client 5] Accepted from localhost (Domain)
D [06/Dec/2018:19:45:00 +0100] [Client 5] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] [Client 5] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 5] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 5] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 5] 2.0 Get-Notifications 42
D [06/Dec/2018:19:45:00 +0100] Get-Notifications /
D [06/Dec/2018:19:45:00 +0100] cupsdIsAuthorized: requesting-user-name="runs"
D [06/Dec/2018:19:45:00 +0100] [Client 5] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 5] Content-Length: 1731
D [06/Dec/2018:19:45:00 +0100] [Client 5] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 5] con->http=0x5630b1d34e00
D [06/Dec/2018:19:45:00 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1731, response=0x5630b1d30a60(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 5] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 5] bytes=0, http_state=0, data_remaining=1731
D [06/Dec/2018:19:45:00 +0100] [Client 5] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 5] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 5] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 5] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 5] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 5] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 5] 2.0 Get-Job-Attributes 43
D [06/Dec/2018:19:45:00 +0100] Get-Job-Attributes ipp://localhost/jobs/17
D [06/Dec/2018:19:45:00 +0100] [Client 5] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 5] Content-Length: 1114
D [06/Dec/2018:19:45:00 +0100] [Client 5] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 5] con->http=0x5630b1d34e00
D [06/Dec/2018:19:45:00 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1114, response=0x5630b1cb1210(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 5] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 5] bytes=0, http_state=0, data_remaining=1114
D [06/Dec/2018:19:45:00 +0100] [Client 5] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 5] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 5] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 6] Server address is "/var/run/cups/cups.sock".
D [06/Dec/2018:19:45:00 +0100] [Client 6] Accepted from localhost (Domain)
D [06/Dec/2018:19:45:00 +0100] [Client 6] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] [Client 6] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 6] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 6] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 6] 2.0 Get-Printer-Attributes 44
D [06/Dec/2018:19:45:00 +0100] Get-Printer-Attributes
D [06/Dec/2018:19:45:00 +0100] Get-Printer-Attributes client-error-not-found: La impresora o clase no existe.
D [06/Dec/2018:19:45:00 +0100] [Client 6] Returning IPP client-error-not-found for Get-Printer-Attributes () from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 6] Content-Length: 125
D [06/Dec/2018:19:45:00 +0100] [Client 6] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 6] con->http=0x5630b1d391d0
D [06/Dec/2018:19:45:00 +0100] [Client 6] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=125, response=0x5630b1d30a80(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 6] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 6] bytes=0, http_state=0, data_remaining=125
D [06/Dec/2018:19:45:00 +0100] [Client 6] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 6] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 6] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 6] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [06/Dec/2018:19:45:00 +0100] [Client 6] Closing connection.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 7] Server address is "/var/run/cups/cups.sock".
D [06/Dec/2018:19:45:00 +0100] [Client 7] Accepted from localhost (Domain)
D [06/Dec/2018:19:45:00 +0100] [Client 7] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] [Client 7] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 7] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 7] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 7] 2.0 Get-Job-Attributes 45
D [06/Dec/2018:19:45:00 +0100] Get-Job-Attributes ipp://localhost/jobs/17
D [06/Dec/2018:19:45:00 +0100] [Client 7] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 7] Content-Length: 194
D [06/Dec/2018:19:45:00 +0100] [Client 7] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 7] con->http=0x5630b1d391d0
D [06/Dec/2018:19:45:00 +0100] [Client 7] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=194, response=0x5630b1d2c370(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 7] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 7] bytes=0, http_state=0, data_remaining=194
D [06/Dec/2018:19:45:00 +0100] [Client 7] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 7] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 7] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 7] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [06/Dec/2018:19:45:00 +0100] [Client 7] Closing connection.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 8] Server address is "/var/run/cups/cups.sock".
D [06/Dec/2018:19:45:00 +0100] [Client 8] Accepted from localhost (Domain)
D [06/Dec/2018:19:45:00 +0100] [Client 8] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] [Client 8] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 8] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 8] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 8] 2.0 Get-Job-Attributes 46
D [06/Dec/2018:19:45:00 +0100] Get-Job-Attributes ipp://localhost/jobs/17
D [06/Dec/2018:19:45:00 +0100] [Client 8] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 8] Content-Length: 101
D [06/Dec/2018:19:45:00 +0100] [Client 8] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 8] con->http=0x5630b1d391d0
D [06/Dec/2018:19:45:00 +0100] [Client 8] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=101, response=0x5630b1d30a80(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 8] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 8] bytes=0, http_state=0, data_remaining=101
D [06/Dec/2018:19:45:00 +0100] [Client 8] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 8] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 8] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 9] Server address is "/var/run/cups/cups.sock".
D [06/Dec/2018:19:45:00 +0100] [Client 9] Accepted from localhost (Domain)
D [06/Dec/2018:19:45:00 +0100] [Client 9] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] [Client 9] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 9] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 9] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 9] 2.0 Get-Printer-Attributes 47
D [06/Dec/2018:19:45:00 +0100] Get-Printer-Attributes ipp://runs-PC/printers/HP-LaserJet-Professional-P1102
D [06/Dec/2018:19:45:00 +0100] [Client 9] Returning IPP successful-ok for Get-Printer-Attributes (ipp://runs-PC/printers/HP-LaserJet-Professional-P1102) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 9] Content-Length: 157
D [06/Dec/2018:19:45:00 +0100] [Client 9] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 9] con->http=0x5630b1d439d0
D [06/Dec/2018:19:45:00 +0100] [Client 9] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=157, response=0x5630b1d2c370(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 9] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 9] bytes=0, http_state=0, data_remaining=157
D [06/Dec/2018:19:45:00 +0100] [Client 9] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 9] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 9] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 9] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 9] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 9] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 9] 2.0 Get-Job-Attributes 48
D [06/Dec/2018:19:45:00 +0100] Get-Job-Attributes ipp://localhost/jobs/17
D [06/Dec/2018:19:45:00 +0100] [Client 9] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 9] Content-Length: 195
D [06/Dec/2018:19:45:00 +0100] [Client 9] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 9] con->http=0x5630b1d439d0
D [06/Dec/2018:19:45:00 +0100] [Client 9] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=195, response=0x5630b1d32090(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 9] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 9] bytes=0, http_state=0, data_remaining=195
D [06/Dec/2018:19:45:00 +0100] [Client 9] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 9] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 9] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 8] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [06/Dec/2018:19:45:00 +0100] [Client 8] Closing connection.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 10] Server address is "/var/run/cups/cups.sock".
D [06/Dec/2018:19:45:00 +0100] [Client 10] Accepted from localhost (Domain)
D [06/Dec/2018:19:45:00 +0100] [Client 10] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] [Client 10] POST / HTTP/1.1
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 10] Read: status=200
D [06/Dec/2018:19:45:00 +0100] [Client 10] No authentication data provided.
D [06/Dec/2018:19:45:00 +0100] [Client 10] 2.0 Get-Job-Attributes 49
D [06/Dec/2018:19:45:00 +0100] Get-Job-Attributes ipp://localhost/jobs/17
D [06/Dec/2018:19:45:00 +0100] [Client 10] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/17) from localhost
D [06/Dec/2018:19:45:00 +0100] [Client 10] Content-Length: 101
D [06/Dec/2018:19:45:00 +0100] [Client 10] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [06/Dec/2018:19:45:00 +0100] [Client 10] con->http=0x5630b1d391d0
D [06/Dec/2018:19:45:00 +0100] [Client 10] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=101, response=0x5630b1cb1150(IPP_STATE_DATA), pipe_pid=0, file=-1
D [06/Dec/2018:19:45:00 +0100] [Client 10] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [06/Dec/2018:19:45:00 +0100] [Client 10] bytes=0, http_state=0, data_remaining=101
D [06/Dec/2018:19:45:00 +0100] [Client 10] Flushing write buffer.
D [06/Dec/2018:19:45:00 +0100] [Client 10] New state is HTTP_STATE_WAITING
D [06/Dec/2018:19:45:00 +0100] [Client 10] Waiting for request.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 10] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [06/Dec/2018:19:45:00 +0100] [Client 10] Closing connection.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [06/Dec/2018:19:45:00 +0100] [Client 5] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [06/Dec/2018:19:45:00 +0100] [Client 5] Closing connection.
D [06/Dec/2018:19:45:00 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
I [06/Dec/2018:19:45:01 +0100] Expiring subscriptions...
1) Restart cups.
1) The printer was removed and re-added
2) Cups and ghostscript purged and reinstalled.
3) hplip purged and reinstalled. It checked with hp-doctor, hp-test... I also try to install the printer with hp-setup.