The advice I received at the time on the forum was to have another fresh install and then follow these steps:
1) Install hplip
Code: Select all
sudo apt install hplip
Code: Select all
sudo usermod -a -G lpadmin pi
It was listed twice. I tried one to begin with and the test print failed saying 'Filter Failed'
This is a copy of the log file from /var/log/cups/error_log
Code: Select all
E [30/May/2019:17:08:29 +0100] [cups-deviced] PID 1391 (gutenprint52+usb) stopped with status 1!
W [30/May/2019:17:09:18 +0100] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id \'HP_LaserJet_P1005-Gray..\' already exists
W [30/May/2019:17:09:18 +0100] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id \'HP_LaserJet_P1005-RGB..\' already exists
E [30/May/2019:17:09:35 +0100] [Job 1] Job stopped due to filter errors; please consult the error_log file for details.
D [30/May/2019:17:09:35 +0100] [Job 1] The following messages were recorded from 17:09:25 to 17:09:35
D [30/May/2019:17:09:35 +0100] [Job 1] Adding start banner page "none".
D [30/May/2019:17:09:35 +0100] [Job 1] Adding end banner page "none".
D [30/May/2019:17:09:35 +0100] [Job 1] File of type application/vnd.cups-pdf-banner queued by "pi".
D [30/May/2019:17:09:35 +0100] [Job 1] hold_until=0
D [30/May/2019:17:09:35 +0100] [Job 1] Queued on "HP_LaserJet_P1005" by "pi".
D [30/May/2019:17:09:35 +0100] [Job 1] time-at-processing=1559232565
D [30/May/2019:17:09:35 +0100] [Job 1] 4 filters for job:
D [30/May/2019:17:09:35 +0100] [Job 1] bannertopdf (application/vnd.cups-pdf-banner to application/pdf, cost 32)
D [30/May/2019:17:09:35 +0100] [Job 1] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [30/May/2019:17:09:35 +0100] [Job 1] gstoraster (application/vnd.cups-pdf to application/vnd.cups-raster, cost 99)
D [30/May/2019:17:09:35 +0100] [Job 1] hpcups (application/vnd.cups-raster to printer/HP_LaserJet_P1005, cost 0)
D [30/May/2019:17:09:35 +0100] [Job 1] job-sheets=none,none
D [30/May/2019:17:09:35 +0100] [Job 1] argv[0]="HP_LaserJet_P1005"
D [30/May/2019:17:09:35 +0100] [Job 1] argv[1]="1"
D [30/May/2019:17:09:35 +0100] [Job 1] argv[2]="pi"
D [30/May/2019:17:09:35 +0100] [Job 1] argv[3]="Test Page"
D [30/May/2019:17:09:35 +0100] [Job 1] argv[4]="1"
D [30/May/2019:17:09:35 +0100] [Job 1] argv[5]="job-uuid=urn:uuid:679ee0f0-2451-30e8-4044-54a0f967d22f job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1559232565 time-at-processing=1559232565"
D [30/May/2019:17:09:35 +0100] [Job 1] argv[6]="/var/spool/cups/d00001-001"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[8]="HOME=/var/spool/cups/tmp"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[10]="SERVER_ADMIN=root@raspberrypi"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[11]="SOFTWARE=CUPS/2.2.1"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[13]="USER=root"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[14]="CUPS_MAX_MESSAGE=2047"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[17]="IPP_PORT=631"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[18]="CHARSET=utf-8"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[19]="LANG=en_GB.UTF-8"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[20]="PPD=/etc/cups/ppd/HP_LaserJet_P1005.ppd"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[21]="RIP_MAX_CACHE=128m"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[23]="DEVICE_URI=usb://HP/LaserJet%20P1005?serial=BC0GFTX"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[24]="PRINTER_INFO=HP LaserJet P1005"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[25]="PRINTER_LOCATION=Living Room"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[26]="PRINTER=HP_LaserJet_P1005"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[27]="PRINTER_STATE_REASONS=none"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[28]="CUPS_FILETYPE=document"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-raster"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[30]="AUTH_I****"
D [30/May/2019:17:09:35 +0100] [Job 1] Started filter /usr/lib/cups/filter/bannertopdf (PID 1516)
D [30/May/2019:17:09:35 +0100] [Job 1] Started filter /usr/lib/cups/filter/pdftopdf (PID 1517)
D [30/May/2019:17:09:35 +0100] [Job 1] Started filter /usr/lib/cups/filter/gstoraster (PID 1518)
D [30/May/2019:17:09:35 +0100] [Job 1] Started filter /usr/lib/cups/filter/hpcups (PID 1519)
D [30/May/2019:17:09:35 +0100] [Job 1] Started backend /usr/lib/cups/backend/usb (PID 1520)
D [30/May/2019:17:09:35 +0100] [Job 1] Loading USB quirks from \"/usr/share/cups/usb\".
D [30/May/2019:17:09:35 +0100] [Job 1] Loaded 132 quirks.
D [30/May/2019:17:09:35 +0100] [Job 1] Printing on printer with URI: usb://HP/LaserJet%20P1005?serial=BC0GFTX
D [30/May/2019:17:09:35 +0100] [Job 1] libusb_get_device_list=5
D [30/May/2019:17:09:35 +0100] [Job 1] STATE: +connecting-to-device
D [30/May/2019:17:09:35 +0100] [Job 1] STATE: -connecting-to-device
D [30/May/2019:17:09:35 +0100] [Job 1] Printer found with device ID: MFG:Hewlett-Packard;MDL:HP LaserJet P1005;CMD:HBS,PJL,ACL;CLS:PRINTER;DES:HP LaserJet P1005;FWVER:20100824; Device URI: usb://HP/LaserJet%20P1005?serial=BC0GFTX
D [30/May/2019:17:09:35 +0100] [Job 1] Device protocol: 2
D [30/May/2019:17:09:35 +0100] [Job 1] Sending data to printer.
D [30/May/2019:17:09:35 +0100] [Job 1] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [30/May/2019:17:09:35 +0100] [Job 1] OUTFORMAT=\"(null)\", so output format will be CUPS/PWG Raster
D [30/May/2019:17:09:35 +0100] [Job 1] pdftopdf: Last filter determined by the PPD: hpcups; FINAL_CONTENT_TYPE: application/vnd.cups-raster => pdftopdf will not log pages in page_log.
D [30/May/2019:17:09:35 +0100] [Job 1] PDF template file doesn\'t have form. It\'s okay.
D [30/May/2019:17:09:35 +0100] [Job 1] PID 1516 (/usr/lib/cups/filter/bannertopdf) exited with no errors.
D [30/May/2019:17:09:35 +0100] [Job 1] Color Manager: Calibration Mode/Off
D [30/May/2019:17:09:35 +0100] [Job 1] PID 1517 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [30/May/2019:17:09:35 +0100] [Job 1] Calling FindDeviceById(cups-HP_LaserJet_P1005)
D [30/May/2019:17:09:35 +0100] [Job 1] Found device /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_P1005
D [30/May/2019:17:09:35 +0100] [Job 1] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors)
D [30/May/2019:17:09:35 +0100] [Job 1] Calling FindDeviceById(cups-HP_LaserJet_P1005)
D [30/May/2019:17:09:35 +0100] [Job 1] Found device /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_P1005
D [30/May/2019:17:09:35 +0100] [Job 1] Calling GetProfileForQualifiers(Gray.Plain....)
D [30/May/2019:17:09:35 +0100] [Job 1] Failed to send: org.freedesktop.ColorManager.Device.NothingMatched:nothing matched expression \'Gray.Plain.,Gray.Plain.*,Gray.*.,Gray.*.*,*\'
D [30/May/2019:17:09:35 +0100] [Job 1] Failed to get profile filename for cups-HP_LaserJet_P1005
D [30/May/2019:17:09:35 +0100] [Job 1] Color Manager: no profiles specified in PPD
D [30/May/2019:17:09:35 +0100] [Job 1] Set job-printer-state-message to "Color Manager: no profiles specified in PPD", current level=INFO
D [30/May/2019:17:09:35 +0100] [Job 1] Color Manager: ICC Profile: None
D [30/May/2019:17:09:35 +0100] [Job 1] Ghostscript using Any-Part-of-Pixel method to fill paths.
D [30/May/2019:17:09:35 +0100] [Job 1] Ghostscript command line: gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -sstdout=%stderr -sOutputFile=%stdout -sDEVICE=cups -sMediaType=Plain -sOutputType=0 -r600x600 -dMediaPosition=7 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=841 -dcupsBitsPerColor=1 -dcupsColorOrder=0 -dcupsColorSpace=3 -dcupsRowCount=1 -dcupsRowStep=2 -dcupsInteger0=9 -dcupsInteger1=600 -scupsPageSizeName=A4 -I/usr/share/cups/fonts -c \'<</.HWMargins[13.560000 13.500000 13.559998 13.500000] /Margins[0 0]>>setpagedevice\' -f -_
D [30/May/2019:17:09:35 +0100] [Job 1] envp[0]=\"CUPS_CACHEDIR=/var/cache/cups\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[1]=\"CUPS_DATADIR=/usr/share/cups\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[2]=\"CUPS_DOCROOT=/usr/share/cups/doc-root\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[3]=\"CUPS_FONTPATH=/usr/share/cups/fonts\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[4]=\"CUPS_REQUESTROOT=/var/spool/cups\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[5]=\"CUPS_SERVERBIN=/usr/lib/cups\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[6]=\"CUPS_SERVERROOT=/etc/cups\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[7]=\"CUPS_STATEDIR=/var/run/cups\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[8]=\"HOME=/var/spool/cups/tmp\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[9]=\"PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[10]=\"SERVER_ADMIN=root@raspberrypi\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[11]=\"SOFTWARE=CUPS/2.2.1\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[12]=\"TMPDIR=/var/spool/cups/tmp\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[13]=\"USER=root\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[14]=\"CUPS_MAX_MESSAGE=2047\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[15]=\"CUPS_SERVER=/var/run/cups/cups.sock\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[16]=\"CUPS_ENCRYPTION=IfRequested\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[17]=\"IPP_PORT=631\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[18]=\"CHARSET=utf-8\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[19]=\"LANG=en_GB.UTF-8\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[20]=\"PPD=/etc/cups/ppd/HP_LaserJet_P1005.ppd\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[21]=\"RIP_MAX_CACHE=128m\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[22]=\"CONTENT_TYPE=application/vnd.cups-pdf-banner\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[23]=\"DEVICE_URI=usb://HP/LaserJet%20P1005?serial=BC0GFTX\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[24]=\"PRINTER_INFO=HP LaserJet P1005\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[25]=\"PRINTER_LOCATION=Living Room\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[26]=\"PRINTER=HP_LaserJet_P1005\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[27]=\"PRINTER_STATE_REASONS=none\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[28]=\"CUPS_FILETYPE=document\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[29]=\"FINAL_CONTENT_TYPE=application/vnd.cups-raster\"
D [30/May/2019:17:09:35 +0100] [Job 1] envp[30]=\"AUTH_INFO_REQUIRED=none\"
D [30/May/2019:17:09:35 +0100] [Job 1] Start rendering...
D [30/May/2019:17:09:35 +0100] [Job 1] Set job-printer-state-message to "Start rendering...", current level=INFO
D [30/May/2019:17:09:35 +0100] [Job 1] Processing page 1...
D [30/May/2019:17:09:35 +0100] [Job 1] Set job-printer-state-message to "Processing page 1...", current level=INFO
D [30/May/2019:17:09:35 +0100] [Job 1] Read 226 bytes of print data...
D [30/May/2019:17:09:35 +0100] [Job 1] Wrote 226 bytes of print data...
D [30/May/2019:17:09:35 +0100] [Job 1] STATE: +hplip.plugin-error
D [30/May/2019:17:09:35 +0100] [Job 1] prnt/hpcups/HPCupsFilter.cpp 486: m_Job initialization failed with error = 48
D [30/May/2019:17:09:35 +0100] [Job 1] Read 36 bytes of print data...
D [30/May/2019:17:09:35 +0100] [Job 1] Wrote 36 bytes of print data...
D [30/May/2019:17:09:35 +0100] [Job 1] Sent 262 bytes...
D [30/May/2019:17:09:35 +0100] [Job 1] PID 1519 (/usr/lib/cups/filter/hpcups) stopped with status 1.
D [30/May/2019:17:09:35 +0100] [Job 1] Hint: Try setting the LogLevel to "debug" to find out more.
D [30/May/2019:17:09:35 +0100] [Job 1] Processing page 2...
D [30/May/2019:17:09:35 +0100] [Job 1] Rendering completed
D [30/May/2019:17:09:35 +0100] [Job 1] PID 1518 (/usr/lib/cups/filter/gstoraster) exited with no errors.
D [30/May/2019:17:09:35 +0100] [Job 1] Waiting for read thread to exit...
D [30/May/2019:17:09:35 +0100] [Job 1] Read thread still active, aborting the pending read...
D [30/May/2019:17:09:35 +0100] [Job 1] PID 1520 (/usr/lib/cups/backend/usb) exited with no errors.
D [30/May/2019:17:09:35 +0100] [Job 1] End of messages
D [30/May/2019:17:09:35 +0100] [Job 1] printer-state=3(idle)
D [30/May/2019:17:09:35 +0100] [Job 1] printer-state-message="Rendering completed"
D [30/May/2019:17:09:35 +0100] [Job 1] printer-state-reasons=hplip.plugin-error
E [30/May/2019:17:10:11 +0100] [cups-deviced] PID 1592 (gutenprint52+usb) stopped with status 1!
W [30/May/2019:17:10:45 +0100] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id \'HP_LaserJet_P100-Gray..\' already exists
W [30/May/2019:17:10:45 +0100] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id \'HP_LaserJet_P100-RGB..\' already exists
E [30/May/2019:17:11:18 +0100] [Job 2] Job stopped due to filter errors; please consult the error_log file for details.
D [30/May/2019:17:11:18 +0100] [Job 2] The following messages were recorded from 17:10:57 to 17:11:18
D [30/May/2019:17:11:18 +0100] [Job 2] Adding start banner page "none".
D [30/May/2019:17:11:18 +0100] [Job 2] Adding end banner page "none".
D [30/May/2019:17:11:18 +0100] [Job 2] File of type application/vnd.cups-pdf-banner queued by "pi".
D [30/May/2019:17:11:18 +0100] [Job 2] hold_until=0
D [30/May/2019:17:11:18 +0100] [Job 2] Queued on "HP_LaserJet_P100" by "pi".
D [30/May/2019:17:11:18 +0100] [Job 2] time-at-processing=1559232657
D [30/May/2019:17:11:18 +0100] [Job 2] 4 filters for job:
D [30/May/2019:17:11:18 +0100] [Job 2] bannertopdf (application/vnd.cups-pdf-banner to application/pdf, cost 32)
D [30/May/2019:17:11:18 +0100] [Job 2] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [30/May/2019:17:11:18 +0100] [Job 2] gstoraster (application/vnd.cups-pdf to application/vnd.cups-raster, cost 99)
D [30/May/2019:17:11:18 +0100] [Job 2] hpcups (application/vnd.cups-raster to printer/HP_LaserJet_P100, cost 0)
D [30/May/2019:17:11:18 +0100] [Job 2] job-sheets=none,none
D [30/May/2019:17:11:18 +0100] [Job 2] argv[0]="HP_LaserJet_P100"
D [30/May/2019:17:11:18 +0100] [Job 2] argv[1]="2"
D [30/May/2019:17:11:18 +0100] [Job 2] argv[2]="pi"
D [30/May/2019:17:11:18 +0100] [Job 2] argv[3]="Test Page"
D [30/May/2019:17:11:18 +0100] [Job 2] argv[4]="1"
D [30/May/2019:17:11:18 +0100] [Job 2] argv[5]="job-uuid=urn:uuid:da5b2cb7-b9d5-3e6e-69b1-9d29e5b6f5a1 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1559232657 time-at-processing=1559232657"
D [30/May/2019:17:11:18 +0100] [Job 2] argv[6]="/var/spool/cups/d00002-001"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[8]="HOME=/var/spool/cups/tmp"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[10]="SERVER_ADMIN=root@raspberrypi"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[11]="SOFTWARE=CUPS/2.2.1"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[13]="USER=root"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[14]="CUPS_MAX_MESSAGE=2047"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[17]="IPP_PORT=631"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[18]="CHARSET=utf-8"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[19]="LANG=en_GB.UTF-8"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[20]="PPD=/etc/cups/ppd/HP_LaserJet_P100.ppd"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[21]="RIP_MAX_CACHE=128m"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[23]="DEVICE_URI=hp:/usb/HP_LaserJet_P1005?serial=BC0GFTX"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[24]="PRINTER_INFO=HP LaserJet P100"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[25]="PRINTER_LOCATION="
D [30/May/2019:17:11:18 +0100] [Job 2] envp[26]="PRINTER=HP_LaserJet_P100"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[27]="PRINTER_STATE_REASONS=none"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[28]="CUPS_FILETYPE=document"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-raster"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[30]="AUTH_I****"
D [30/May/2019:17:11:18 +0100] [Job 2] Started filter /usr/lib/cups/filter/bannertopdf (PID 1669)
D [30/May/2019:17:11:18 +0100] [Job 2] Started filter /usr/lib/cups/filter/pdftopdf (PID 1670)
D [30/May/2019:17:11:18 +0100] [Job 2] Started filter /usr/lib/cups/filter/gstoraster (PID 1671)
D [30/May/2019:17:11:18 +0100] [Job 2] Started filter /usr/lib/cups/filter/hpcups (PID 1672)
D [30/May/2019:17:11:18 +0100] [Job 2] Started backend /usr/lib/cups/backend/hp (PID 1673)
D [30/May/2019:17:11:18 +0100] [Job 2] OUTFORMAT=\"(null)\", so output format will be CUPS/PWG Raster
D [30/May/2019:17:11:18 +0100] [Job 2] pdftopdf: Last filter determined by the PPD: hpcups; FINAL_CONTENT_TYPE: application/vnd.cups-raster => pdftopdf will not log pages in page_log.
D [30/May/2019:17:11:18 +0100] [Job 2] PDF template file doesn\'t have form. It\'s okay.
D [30/May/2019:17:11:18 +0100] [Job 2] PID 1669 (/usr/lib/cups/filter/bannertopdf) exited with no errors.
D [30/May/2019:17:11:18 +0100] [Job 2] PID 1670 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [30/May/2019:17:11:18 +0100] [Job 2] Color Manager: Calibration Mode/Off
D [30/May/2019:17:11:18 +0100] [Job 2] Calling FindDeviceById(cups-HP_LaserJet_P100)
D [30/May/2019:17:11:18 +0100] [Job 2] Found device /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_P100
D [30/May/2019:17:11:18 +0100] [Job 2] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors)
D [30/May/2019:17:11:18 +0100] [Job 2] Calling FindDeviceById(cups-HP_LaserJet_P100)
D [30/May/2019:17:11:18 +0100] [Job 2] Found device /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_P100
D [30/May/2019:17:11:18 +0100] [Job 2] Calling GetProfileForQualifiers(Gray.Plain....)
D [30/May/2019:17:11:18 +0100] [Job 2] Failed to send: org.freedesktop.ColorManager.Device.NothingMatched:nothing matched expression \'Gray.Plain.,Gray.Plain.*,Gray.*.,Gray.*.*,*\'
D [30/May/2019:17:11:18 +0100] [Job 2] Failed to get profile filename for cups-HP_LaserJet_P100
D [30/May/2019:17:11:18 +0100] [Job 2] Color Manager: no profiles specified in PPD
D [30/May/2019:17:11:18 +0100] [Job 2] Set job-printer-state-message to "Color Manager: no profiles specified in PPD", current level=INFO
D [30/May/2019:17:11:18 +0100] [Job 2] Color Manager: ICC Profile: None
D [30/May/2019:17:11:18 +0100] [Job 2] Ghostscript using Any-Part-of-Pixel method to fill paths.
D [30/May/2019:17:11:18 +0100] [Job 2] Ghostscript command line: gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -sstdout=%stderr -sOutputFile=%stdout -sDEVICE=cups -sMediaType=Plain -sOutputType=0 -r600x600 -dMediaPosition=7 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=841 -dcupsBitsPerColor=1 -dcupsColorOrder=0 -dcupsColorSpace=3 -dcupsRowCount=1 -dcupsRowStep=2 -dcupsInteger0=9 -dcupsInteger1=600 -scupsPageSizeName=A4 -I/usr/share/cups/fonts -c \'<</.HWMargins[13.560000 13.500000 13.559998 13.500000] /Margins[0 0]>>setpagedevice\' -f -_
D [30/May/2019:17:11:18 +0100] [Job 2] envp[0]=\"CUPS_CACHEDIR=/var/cache/cups\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[1]=\"CUPS_DATADIR=/usr/share/cups\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[2]=\"CUPS_DOCROOT=/usr/share/cups/doc-root\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[3]=\"CUPS_FONTPATH=/usr/share/cups/fonts\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[4]=\"CUPS_REQUESTROOT=/var/spool/cups\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[5]=\"CUPS_SERVERBIN=/usr/lib/cups\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[6]=\"CUPS_SERVERROOT=/etc/cups\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[7]=\"CUPS_STATEDIR=/var/run/cups\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[8]=\"HOME=/var/spool/cups/tmp\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[9]=\"PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[10]=\"SERVER_ADMIN=root@raspberrypi\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[11]=\"SOFTWARE=CUPS/2.2.1\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[12]=\"TMPDIR=/var/spool/cups/tmp\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[13]=\"USER=root\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[14]=\"CUPS_MAX_MESSAGE=2047\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[15]=\"CUPS_SERVER=/var/run/cups/cups.sock\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[16]=\"CUPS_ENCRYPTION=IfRequested\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[17]=\"IPP_PORT=631\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[18]=\"CHARSET=utf-8\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[19]=\"LANG=en_GB.UTF-8\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[20]=\"PPD=/etc/cups/ppd/HP_LaserJet_P100.ppd\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[21]=\"RIP_MAX_CACHE=128m\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[22]=\"CONTENT_TYPE=application/vnd.cups-pdf-banner\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[23]=\"DEVICE_URI=hp:/usb/HP_LaserJet_P1005?serial=BC0GFTX\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[24]=\"PRINTER_INFO=HP LaserJet P100\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[25]=\"PRINTER_LOCATION=\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[26]=\"PRINTER=HP_LaserJet_P100\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[27]=\"PRINTER_STATE_REASONS=none\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[28]=\"CUPS_FILETYPE=document\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[29]=\"FINAL_CONTENT_TYPE=application/vnd.cups-raster\"
D [30/May/2019:17:11:18 +0100] [Job 2] envp[30]=\"AUTH_INFO_REQUIRED=none\"
D [30/May/2019:17:11:18 +0100] [Job 2] Start rendering...
D [30/May/2019:17:11:18 +0100] [Job 2] Set job-printer-state-message to "Start rendering...", current level=INFO
D [30/May/2019:17:11:18 +0100] [Job 2] Processing page 1...
D [30/May/2019:17:11:18 +0100] [Job 2] Set job-printer-state-message to "Processing page 1...", current level=INFO
D [30/May/2019:17:11:18 +0100] [Job 2] STATE: +connecting-to-device
D [30/May/2019:17:11:18 +0100] [Job 2] PID 1672 (/usr/lib/cups/filter/hpcups) stopped with status 1.
D [30/May/2019:17:11:18 +0100] [Job 2] Hint: Try setting the LogLevel to "debug" to find out more.
D [30/May/2019:17:11:18 +0100] [Job 2] STATE: +hplip.plugin-error
D [30/May/2019:17:11:18 +0100] [Job 2] prnt/hpcups/HPCupsFilter.cpp 486: m_Job initialization failed with error = 48
D [30/May/2019:17:11:18 +0100] [Job 2] Processing page 2...
D [30/May/2019:17:11:18 +0100] [Job 2] STATE: -connecting-to-device
D [30/May/2019:17:11:18 +0100] [Job 2] STATE: -media-empty-error,media-jam-error,hplip.plugin-error,cover-open-error,toner-empty-error,other
D [30/May/2019:17:11:18 +0100] [Job 2] Rendering completed
D [30/May/2019:17:11:18 +0100] [Job 2] PID 1671 (/usr/lib/cups/filter/gstoraster) exited with no errors.
D [30/May/2019:17:11:18 +0100] [Job 2] prnt/backend/hp.c 376: read new pjl status: 10023
D [30/May/2019:17:11:18 +0100] [Job 2] prnt/backend/hp.c 378: read pjl job_end: 0
D [30/May/2019:17:11:18 +0100] [Job 2] prnt/backend/hp.c 376: read new pjl status: 10001
D [30/May/2019:17:11:18 +0100] [Job 2] ready to print
D [30/May/2019:17:11:18 +0100] [Job 2] PID 1673 (/usr/lib/cups/backend/hp) exited with no errors.
D [30/May/2019:17:11:18 +0100] [Job 2] End of messages
D [30/May/2019:17:11:18 +0100] [Job 2] printer-state=3(idle)
D [30/May/2019:17:11:18 +0100] [Job 2] printer-state-message="ready to print"
D [30/May/2019:17:11:18 +0100] [Job 2] printer-state-reasons=none
E [30/May/2019:17:12:56 +0100] [Job 3] Job stopped due to filter errors; please consult the error_log file for details.
D [30/May/2019:17:12:56 +0100] [Job 3] The following messages were recorded from 17:12:35 to 17:12:56
D [30/May/2019:17:12:56 +0100] [Job 3] Adding start banner page "none".
D [30/May/2019:17:12:56 +0100] [Job 3] Adding end banner page "none".
D [30/May/2019:17:12:56 +0100] [Job 3] File of type application/vnd.cups-pdf-banner queued by "pi".
D [30/May/2019:17:12:56 +0100] [Job 3] hold_until=0
D [30/May/2019:17:12:56 +0100] [Job 3] Queued on "HP_LaserJet_P100" by "pi".
D [30/May/2019:17:12:56 +0100] [Job 3] time-at-processing=1559232755
D [30/May/2019:17:12:56 +0100] [Job 3] 4 filters for job:
D [30/May/2019:17:12:56 +0100] [Job 3] bannertopdf (application/vnd.cups-pdf-banner to application/pdf, cost 32)
D [30/May/2019:17:12:56 +0100] [Job 3] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [30/May/2019:17:12:56 +0100] [Job 3] gstoraster (application/vnd.cups-pdf to application/vnd.cups-raster, cost 99)
D [30/May/2019:17:12:56 +0100] [Job 3] hpcups (application/vnd.cups-raster to printer/HP_LaserJet_P100, cost 0)
D [30/May/2019:17:12:56 +0100] [Job 3] job-sheets=none,none
D [30/May/2019:17:12:56 +0100] [Job 3] argv[0]="HP_LaserJet_P100"
D [30/May/2019:17:12:56 +0100] [Job 3] argv[1]="3"
D [30/May/2019:17:12:56 +0100] [Job 3] argv[2]="pi"
D [30/May/2019:17:12:56 +0100] [Job 3] argv[3]="Test Page"
D [30/May/2019:17:12:56 +0100] [Job 3] argv[4]="1"
D [30/May/2019:17:12:56 +0100] [Job 3] argv[5]="job-uuid=urn:uuid:81b1cb63-739c-37af-5f07-571231a1b3a2 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1559232755 time-at-processing=1559232755"
D [30/May/2019:17:12:56 +0100] [Job 3] argv[6]="/var/spool/cups/d00003-001"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[8]="HOME=/var/spool/cups/tmp"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[10]="SERVER_ADMIN=root@raspberrypi"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[11]="SOFTWARE=CUPS/2.2.1"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[13]="USER=root"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[14]="CUPS_MAX_MESSAGE=2047"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[17]="IPP_PORT=631"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[18]="CHARSET=utf-8"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[19]="LANG=en_GB.UTF-8"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[20]="PPD=/etc/cups/ppd/HP_LaserJet_P100.ppd"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[21]="RIP_MAX_CACHE=128m"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[23]="DEVICE_URI=hp:/usb/HP_LaserJet_P1005?serial=BC0GFTX"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[24]="PRINTER_INFO=HP LaserJet P100"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[25]="PRINTER_LOCATION="
D [30/May/2019:17:12:56 +0100] [Job 3] envp[26]="PRINTER=HP_LaserJet_P100"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[27]="PRINTER_STATE_REASONS=none"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[28]="CUPS_FILETYPE=document"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-raster"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[30]="AUTH_I****"
D [30/May/2019:17:12:56 +0100] [Job 3] Started filter /usr/lib/cups/filter/bannertopdf (PID 1793)
D [30/May/2019:17:12:56 +0100] [Job 3] Started filter /usr/lib/cups/filter/pdftopdf (PID 1794)
D [30/May/2019:17:12:56 +0100] [Job 3] Started filter /usr/lib/cups/filter/gstoraster (PID 1795)
D [30/May/2019:17:12:56 +0100] [Job 3] Started filter /usr/lib/cups/filter/hpcups (PID 1796)
D [30/May/2019:17:12:56 +0100] [Job 3] Started backend /usr/lib/cups/backend/hp (PID 1797)
D [30/May/2019:17:12:56 +0100] [Job 3] pdftopdf: Last filter determined by the PPD: hpcups; FINAL_CONTENT_TYPE: application/vnd.cups-raster => pdftopdf will not log pages in page_log.
D [30/May/2019:17:12:56 +0100] [Job 3] PDF template file doesn\'t have form. It\'s okay.
D [30/May/2019:17:12:56 +0100] [Job 3] OUTFORMAT=\"(null)\", so output format will be CUPS/PWG Raster
D [30/May/2019:17:12:56 +0100] [Job 3] PID 1793 (/usr/lib/cups/filter/bannertopdf) exited with no errors.
D [30/May/2019:17:12:56 +0100] [Job 3] Color Manager: Calibration Mode/Off
D [30/May/2019:17:12:56 +0100] [Job 3] PID 1794 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [30/May/2019:17:12:56 +0100] [Job 3] Calling FindDeviceById(cups-HP_LaserJet_P100)
D [30/May/2019:17:12:56 +0100] [Job 3] Found device /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_P100
D [30/May/2019:17:12:56 +0100] [Job 3] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors)
D [30/May/2019:17:12:56 +0100] [Job 3] Calling FindDeviceById(cups-HP_LaserJet_P100)
D [30/May/2019:17:12:56 +0100] [Job 3] Found device /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_P100
D [30/May/2019:17:12:56 +0100] [Job 3] Calling GetProfileForQualifiers(Gray.Plain....)
D [30/May/2019:17:12:56 +0100] [Job 3] Failed to send: org.freedesktop.ColorManager.Device.NothingMatched:nothing matched expression \'Gray.Plain.,Gray.Plain.*,Gray.*.,Gray.*.*,*\'
D [30/May/2019:17:12:56 +0100] [Job 3] Failed to get profile filename for cups-HP_LaserJet_P100
D [30/May/2019:17:12:56 +0100] [Job 3] Color Manager: no profiles specified in PPD
D [30/May/2019:17:12:56 +0100] [Job 3] Set job-printer-state-message to "Color Manager: no profiles specified in PPD", current level=INFO
D [30/May/2019:17:12:56 +0100] [Job 3] Color Manager: ICC Profile: None
D [30/May/2019:17:12:56 +0100] [Job 3] Ghostscript using Any-Part-of-Pixel method to fill paths.
D [30/May/2019:17:12:56 +0100] [Job 3] Ghostscript command line: gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -sstdout=%stderr -sOutputFile=%stdout -sDEVICE=cups -sMediaType=Plain -sOutputType=0 -r600x600 -dMediaPosition=7 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=841 -dcupsBitsPerColor=1 -dcupsColorOrder=0 -dcupsColorSpace=3 -dcupsRowCount=1 -dcupsRowStep=2 -dcupsInteger0=9 -dcupsInteger1=600 -scupsPageSizeName=A4 -I/usr/share/cups/fonts -c \'<</.HWMargins[13.560000 13.500000 13.559998 13.500000] /Margins[0 0]>>setpagedevice\' -f -_
D [30/May/2019:17:12:56 +0100] [Job 3] envp[0]=\"CUPS_CACHEDIR=/var/cache/cups\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[1]=\"CUPS_DATADIR=/usr/share/cups\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[2]=\"CUPS_DOCROOT=/usr/share/cups/doc-root\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[3]=\"CUPS_FONTPATH=/usr/share/cups/fonts\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[4]=\"CUPS_REQUESTROOT=/var/spool/cups\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[5]=\"CUPS_SERVERBIN=/usr/lib/cups\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[6]=\"CUPS_SERVERROOT=/etc/cups\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[7]=\"CUPS_STATEDIR=/var/run/cups\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[8]=\"HOME=/var/spool/cups/tmp\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[9]=\"PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[10]=\"SERVER_ADMIN=root@raspberrypi\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[11]=\"SOFTWARE=CUPS/2.2.1\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[12]=\"TMPDIR=/var/spool/cups/tmp\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[13]=\"USER=root\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[14]=\"CUPS_MAX_MESSAGE=2047\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[15]=\"CUPS_SERVER=/var/run/cups/cups.sock\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[16]=\"CUPS_ENCRYPTION=IfRequested\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[17]=\"IPP_PORT=631\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[18]=\"CHARSET=utf-8\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[19]=\"LANG=en_GB.UTF-8\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[20]=\"PPD=/etc/cups/ppd/HP_LaserJet_P100.ppd\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[21]=\"RIP_MAX_CACHE=128m\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[22]=\"CONTENT_TYPE=application/vnd.cups-pdf-banner\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[23]=\"DEVICE_URI=hp:/usb/HP_LaserJet_P1005?serial=BC0GFTX\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[24]=\"PRINTER_INFO=HP LaserJet P100\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[25]=\"PRINTER_LOCATION=\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[26]=\"PRINTER=HP_LaserJet_P100\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[27]=\"PRINTER_STATE_REASONS=none\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[28]=\"CUPS_FILETYPE=document\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[29]=\"FINAL_CONTENT_TYPE=application/vnd.cups-raster\"
D [30/May/2019:17:12:56 +0100] [Job 3] envp[30]=\"AUTH_INFO_REQUIRED=none\"
D [30/May/2019:17:12:56 +0100] [Job 3] Start rendering...
D [30/May/2019:17:12:56 +0100] [Job 3] Set job-printer-state-message to "Start rendering...", current level=INFO
D [30/May/2019:17:12:56 +0100] [Job 3] Processing page 1...
D [30/May/2019:17:12:56 +0100] [Job 3] Set job-printer-state-message to "Processing page 1...", current level=INFO
D [30/May/2019:17:12:56 +0100] [Job 3] STATE: +connecting-to-device
D [30/May/2019:17:12:56 +0100] [Job 3] STATE: +hplip.plugin-error
D [30/May/2019:17:12:56 +0100] [Job 3] prnt/hpcups/HPCupsFilter.cpp 486: m_Job initialization failed with error = 48
D [30/May/2019:17:12:56 +0100] [Job 3] PID 1796 (/usr/lib/cups/filter/hpcups) stopped with status 1.
D [30/May/2019:17:12:56 +0100] [Job 3] Hint: Try setting the LogLevel to "debug" to find out more.
D [30/May/2019:17:12:56 +0100] [Job 3] STATE: -connecting-to-device
D [30/May/2019:17:12:56 +0100] [Job 3] STATE: -media-empty-error,media-jam-error,hplip.plugin-error,cover-open-error,toner-empty-error,other
D [30/May/2019:17:12:56 +0100] [Job 3] Processing page 2...
D [30/May/2019:17:12:56 +0100] [Job 3] Rendering completed
D [30/May/2019:17:12:56 +0100] [Job 3] PID 1795 (/usr/lib/cups/filter/gstoraster) exited with no errors.
D [30/May/2019:17:12:56 +0100] [Job 3] prnt/backend/hp.c 376: read new pjl status: 10023
D [30/May/2019:17:12:56 +0100] [Job 3] prnt/backend/hp.c 378: read pjl job_end: 0
D [30/May/2019:17:12:56 +0100] [Job 3] prnt/backend/hp.c 376: read new pjl status: 10001
D [30/May/2019:17:12:56 +0100] [Job 3] ready to print
D [30/May/2019:17:12:56 +0100] [Job 3] PID 1797 (/usr/lib/cups/backend/hp) exited with no errors.
D [30/May/2019:17:12:56 +0100] [Job 3] End of messages
D [30/May/2019:17:12:56 +0100] [Job 3] printer-state=3(idle)
D [30/May/2019:17:12:56 +0100] [Job 3] printer-state-message="ready to print"
D [30/May/2019:17:12:56 +0100] [Job 3] printer-state-reasons=none
E [30/May/2019:17:13:40 +0100] [cups-deviced] PID 1948 (gutenprint52+usb) stopped with status 1!