foomatic, ghostscript, cups misworking

by **icy6210** » Tue Dec 03, 2013 1:21 am

I cant’t print since systemd.
The platform is
$this->bbcode_second_pass_code('', '$ uname -a
Linux jack 3.1.10-28-ARCH #1 PREEMPT Thu Oct 17 22:11:45 CDT 2013 armv5tel GNU/Linux')
on Icybox 6210
I can use it as a print server no more so narrowed the problem configuring only the local printer and proving to print as local user ssh connected.
The printer Brother hl2030 works perfectly as client and server with another two archlinux machines (x86/x86_64).
I have the system uptodate, the printing software installed is:

If I send a text file (printers.conf) to the printer the printer does nothing, freezes with the msg “Sending data to printer”.
If send a postscript file
$this->bbcode_second_pass_code('', '$ enscript printers.conf')
The printer produces a blank page.
Here the cups’s error_log
$this->bbcode_second_pass_code('', '
I [02/Dec/2013:15:35:51 +0100] [Job 56] Adding start banner page "none".
I [02/Dec/2013:15:35:51 +0100] [Job 56] Queued on "bj" by "admin".
D [02/Dec/2013:15:35:51 +0100] [Job 56] Auto-typing file...
D [02/Dec/2013:15:35:51 +0100] [Job 56] Request file type is application/postscript.
I [02/Dec/2013:15:35:51 +0100] [Job 56] File of type application/postscript queued by "admin".
I [02/Dec/2013:15:35:51 +0100] [Job 56] Adding end banner page "none".
D [02/Dec/2013:15:35:52 +0100] [Job 56] time-at-processing=1385994952
D [02/Dec/2013:15:35:52 +0100] [Job 56] 3 filters for job:
D [02/Dec/2013:15:35:52 +0100] [Job 56] pstopdf (application/postscript to application/pdf, cost 0)
D [02/Dec/2013:15:35:52 +0100] [Job 56] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [02/Dec/2013:15:35:52 +0100] [Job 56] foomatic-rip (application/vnd.cups-pdf to printer/bj, cost 0)
D [02/Dec/2013:15:35:52 +0100] [Job 56] job-sheets=none,none
D [02/Dec/2013:15:35:52 +0100] [Job 56] argv[0]="bj"
D [02/Dec/2013:15:35:52 +0100] [Job 56] argv[1]="56"
D [02/Dec/2013:15:35:52 +0100] [Job 56] argv[2]="admin"
D [02/Dec/2013:15:35:52 +0100] [Job 56] argv[3]="printers.ps"
D [02/Dec/2013:15:35:52 +0100] [Job 56] argv[4]="1"
D [02/Dec/2013:15:35:52 +0100] [Job 56] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:0867c0e7-5b64-30dd-5ffa-1ea6fa8a0a4e job-originating-host-name=localhost time-at-creation=1385994951 time-at-processing=1385994952"
D [02/Dec/2013:15:35:52 +0100] [Job 56] argv[6]="/var/spool/cups/d00056-001"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[7]="CUPS_STATEDIR=/run/cups"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[8]="HOME=/var/spool/cups/tmp"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[10]="SERVER_ADMIN=root@jack"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[11]="SOFTWARE=CUPS/1.7.0"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[13]="USER=root"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[14]="CUPS_MAX_MESSAGE=2047"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[15]="CUPS_SERVER=/run/cups/cups.sock"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[17]="IPP_PORT=631"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[18]="CHARSET=utf-8"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[19]="LANG=en_US.UTF-8"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[20]="PPD=/etc/cups/ppd/bj.ppd"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[21]="RIP_MAX_CACHE=128m"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[22]="CONTENT_TYPE=application/postscript"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[23]="DEVICE_URI=usb://Brother/HL-2030%20series?serial=D7J580621"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[24]="PRINTER_INFO=Brother HL-2030 series"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[25]="PRINTER_LOCATION=jack"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[26]="PRINTER=bj"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[27]="PRINTER_STATE_REASONS=none"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[28]="CUPS_FILETYPE=document"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[29]="FINAL_CONTENT_TYPE=printer/bj"
D [02/Dec/2013:15:35:52 +0100] [Job 56] envp[30]="AUTH_I****"
I [02/Dec/2013:15:35:52 +0100] [Job 56] Started filter /usr/lib/cups/filter/pstopdf (PID 7225)
I [02/Dec/2013:15:35:52 +0100] [Job 56] Started filter /usr/lib/cups/filter/pdftopdf (PID 7226)
I [02/Dec/2013:15:35:52 +0100] [Job 56] Started filter /usr/lib/cups/filter/foomatic-rip (PID 7227)
I [02/Dec/2013:15:35:52 +0100] [Job 56] Started backend /usr/lib/cups/backend/usb (PID 7228)
D [02/Dec/2013:15:35:52 +0100] [Job 56] Getting input from file
D [02/Dec/2013:15:35:52 +0100] [Job 56] foomatic-rip version 4.0.17.256 running...
D [02/Dec/2013:15:35:52 +0100] [Job 56] Parsing PPD file ...
D [02/Dec/2013:15:35:52 +0100] [Job 56] Added option ColorSpace
D [02/Dec/2013:15:35:52 +0100] [Job 56] Added option PageSize
D [02/Dec/2013:15:35:52 +0100] [Job 56] Added option ImageableArea
D [02/Dec/2013:15:35:52 +0100] [Job 56] Added option PaperDimension
D [02/Dec/2013:15:35:52 +0100] [Job 56] Added option EconoMode
D [02/Dec/2013:15:35:52 +0100] [Job 56] Added option InputSlot
D [02/Dec/2013:15:35:52 +0100] [Job 56] Added option Resolution
D [02/Dec/2013:15:35:52 +0100] [Job 56] Added option MediaType
D [02/Dec/2013:15:35:52 +0100] [Job 56] Added option HalftoningAlgorithm
D [02/Dec/2013:15:35:52 +0100] [Job 56] Loading USB quirks from "/usr/share/cups/usb".
D [02/Dec/2013:15:35:52 +0100] [Job 56] Loaded 67 quirks.
D [02/Dec/2013:15:35:52 +0100] [Job 56] Printing on printer with URI: usb://Brother/HL-2030%20series?serial=D7J580621
D [02/Dec/2013:15:35:52 +0100] [Job 56] Added option Font
D [02/Dec/2013:15:35:52 +0100] [Job 56] Parameter Summary
D [02/Dec/2013:15:35:52 +0100] [Job 56] -----------------
D [02/Dec/2013:15:35:52 +0100] [Job 56] Spooler: cups
D [02/Dec/2013:15:35:52 +0100] [Job 56] Printer: bj
D [02/Dec/2013:15:35:52 +0100] [Job 56] Shell: /bin/bash
D [02/Dec/2013:15:35:52 +0100] [Job 56] PPD file: /etc/cups/ppd/bj.ppd
D [02/Dec/2013:15:35:52 +0100] [Job 56] ATTR file:
D [02/Dec/2013:15:35:52 +0100] [Job 56] Printer model: Brother HL-2030 Foomatic/hl1250 (recommended)
D [02/Dec/2013:15:35:52 +0100] [Job 56] Job title: printers.ps
D [02/Dec/2013:15:35:52 +0100] [Job 56] File(s) to be printed:
D [02/Dec/2013:15:35:52 +0100] [Job 56] <STDIN>
D [02/Dec/2013:15:35:52 +0100] [Job 56] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [02/Dec/2013:15:35:52 +0100] [Job 56] Printing system options:
D [02/Dec/2013:15:35:52 +0100] [Job 56] Pondering option 'finishings=3'
D [02/Dec/2013:15:35:52 +0100] [Job 56] Unknown option finishings=3.
D [02/Dec/2013:15:35:52 +0100] [Job 56] Pondering option 'number-up=1'
D [02/Dec/2013:15:35:52 +0100] [Job 56] Unknown option number-up=1.
D [02/Dec/2013:15:35:52 +0100] [Job 56] Pondering option 'job-uuid=urn:uuid:0867c0e7-5b64-30dd-5ffa-1ea6fa8a0a4e'
D [02/Dec/2013:15:35:52 +0100] [Job 56] Unknown option job-uuid=urn:uuid:0867c0e7-5b64-30dd-5ffa-1ea6fa8a0a4e.
D [02/Dec/2013:15:35:52 +0100] [Job 56] Pondering option 'job-originating-host-name=localhost'
D [02/Dec/2013:15:35:52 +0100] [Job 56] Unknown option job-originating-host-name=localhost.
D [02/Dec/2013:15:35:52 +0100] [Job 56] Pondering option 'time-at-creation=1385994951'
D [02/Dec/2013:15:35:52 +0100] [Job 56] Unknown option time-at-creation=1385994951.
D [02/Dec/2013:15:35:52 +0100] [Job 56] Pondering option 'time-at-processing=1385994952'
D [02/Dec/2013:15:35:52 +0100] [Job 56] Unknown option time-at-processing=1385994952.
D [02/Dec/2013:15:35:52 +0100] [Job 56] Options from the PPD file:
D [02/Dec/2013:15:35:52 +0100] [Job 56] ================================================
D [02/Dec/2013:15:35:52 +0100] [Job 56] File: <STDIN>
D [02/Dec/2013:15:35:52 +0100] [Job 56] ================================================
D [02/Dec/2013:15:35:52 +0100] [Job 56] libusb_get_device_list=4
D [02/Dec/2013:15:35:52 +0100] [Job 56] STATE: +connecting-to-device
D [02/Dec/2013:15:35:52 +0100] [Job 56] STATE: -connecting-to-device
D [02/Dec/2013:15:35:52 +0100] [Job 56] pstopdf 6 args: 56 admin printers.ps 1 finishings=3 number-up=1 job-uuid=urn:uuid:0867c0e7-5b64-30dd-5ffa-1ea6fa8a0a4e job-originating-host-name=localhost time-at-creation=1385994951 time-at-processing=1385994952 /var/spool/cups/d00056-001
D [02/Dec/2013:15:35:52 +0100] [Job 56] PPD: /etc/cups/ppd/bj.ppd
D [02/Dec/2013:15:35:52 +0100] [Job 56] Device protocol: 2
I [02/Dec/2013:15:35:52 +0100] [Job 56] Sending data to printer.
D [02/Dec/2013:15:35:52 +0100] [Job 56] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [02/Dec/2013:15:35:52 +0100] [Job 56] Resolution: 600x600
D [02/Dec/2013:15:35:53 +0100] [Job 56] Page size: A4
D [02/Dec/2013:15:35:53 +0100] [Job 56] Width: 595, height: 842, absolute margins: 18, 36, 577, 806
D [02/Dec/2013:15:35:53 +0100] [Job 56] Relative margins: 18, 36, 18, 36
D [02/Dec/2013:15:35:53 +0100] [Job 56] PPD options: -r600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842
D [02/Dec/2013:15:35:53 +0100] [Job 56] PostScript to be injected:
D [02/Dec/2013:15:35:53 +0100] [Job 56] Running cat | /usr/bin/gs -q -dNOPAUSE -dBATCH -sDEVICE=pdfwrite -dCompatibilityLevel=1.3 -dAutoRotatePages=/None -dAutoFilterColorImages=false -dNOPLATFONTS -dPARANOIDSAFER -dNOINTERPOLATE -sstdout=%stderr -dColorImageFilter=/FlateEncode -dPDFSETTINGS=/printer -dUseCIEColor -dColorConversionStrategy=/LeaveColorUnchanged -dDoNumCopies -r600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -sOutputFile=- -c .setpdfwrite -f -
D [02/Dec/2013:15:35:55 +0100] [Job 56] PID 7225 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [02/Dec/2013:15:35:55 +0100] [Job 56] Filetype: PDF
D [02/Dec/2013:15:35:55 +0100] [Job 56] Storing temporary files in /var/spool/cups/tmp
D [02/Dec/2013:15:35:55 +0100] [Job 56] PID 7226 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [02/Dec/2013:15:35:56 +0100] [Job 56] File contains 1 pages
D [02/Dec/2013:15:35:56 +0100] [Job 56] Starting renderer with command: gs -dFirstPage=1 -q -dBATCH -dPARANOIDSAFER -dNOPAUSE -sDEVICE=hl1250 -dEconoMode=0 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -r600x600 -dSourceTray=0 -dPaperType=0 -sOutputFile=- -c '/Default << /SpotFunction { 180 mul cos exch 180 mul cos add 2 div } bind /HalftoneType 1 /AccurateScreens true /Frequency 137 /Angle 37 /HalftoneName (Round Dot Screen) >> /Halftone defineresource sethalftone << /HalftoneMode 1 /UseWTS false /AccurateScreens true >> setuserparams' -f /var/spool/cups/tmp/foomatic-aG0UNL
D [02/Dec/2013:15:35:56 +0100] [Job 56] Starting process "kid3" (generation 1)
D [02/Dec/2013:15:35:56 +0100] [Job 56] Starting process "kid4" (generation 2)
D [02/Dec/2013:15:35:56 +0100] [Job 56] Starting process "renderer" (generation 2)
D [02/Dec/2013:15:35:56 +0100] [Job 56] JCL: 2345X@PJL
D [02/Dec/2013:15:35:56 +0100] [Job 56] <job data>
D [02/Dec/2013:15:35:57 +0100] [Job 56] renderer exited with status 0
D [02/Dec/2013:15:35:57 +0100] [Job 56] Read 306 bytes of print data...
D [02/Dec/2013:15:35:57 +0100] [Job 56] kid4 exited with status 0
D [02/Dec/2013:15:35:57 +0100] [Job 56] kid3 finished
D [02/Dec/2013:15:35:57 +0100] [Job 56] Wrote 306 bytes of print data...
D [02/Dec/2013:15:35:57 +0100] [Job 56] Kid3 exit status: 0
D [02/Dec/2013:15:35:57 +0100] [Job 56] Closing foomatic-rip.
D [02/Dec/2013:15:35:57 +0100] [Job 56] Sent 306 bytes...
D [02/Dec/2013:15:35:57 +0100] [Job 56] Waiting for read thread to exit...
D [02/Dec/2013:15:35:57 +0100] [Job 56] PID 7227 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.
D [02/Dec/2013:15:35:57 +0100] [Job 56] PID 7228 (/usr/lib/cups/backend/usb) exited with no errors.
D [02/Dec/2013:15:35:57 +0100] [Job 56] time-at-completed=1385994957
I [02/Dec/2013:15:35:57 +0100] [Job 56] Job completed.
D [02/Dec/2013:15:35:58 +0100] [Job 56] Unloading...
')
If I convert the file to pdf and send it to the printer, printers do nothing.
Here the cups’s error_log
$this->bbcode_second_pass_code('', '
I [02/Dec/2013:15:35:10 +0100] [Job 55] Adding start banner page "none".
I [02/Dec/2013:15:35:10 +0100] [Job 55] Queued on "bj" by "admin".
D [02/Dec/2013:15:35:10 +0100] [Job 55] Auto-typing file...
D [02/Dec/2013:15:35:10 +0100] [Job 55] Request file type is application/pdf.
I [02/Dec/2013:15:35:10 +0100] [Job 55] File of type application/pdf queued by "admin".
I [02/Dec/2013:15:35:10 +0100] [Job 55] Adding end banner page "none".
D [02/Dec/2013:15:35:10 +0100] [Job 55] time-at-processing=1385994910
D [02/Dec/2013:15:35:10 +0100] [Job 55] 2 filters for job:
D [02/Dec/2013:15:35:10 +0100] [Job 55] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [02/Dec/2013:15:35:10 +0100] [Job 55] foomatic-rip (application/vnd.cups-pdf to printer/bj, cost 0)
D [02/Dec/2013:15:35:10 +0100] [Job 55] job-sheets=none,none
D [02/Dec/2013:15:35:10 +0100] [Job 55] argv[0]="bj"
D [02/Dec/2013:15:35:10 +0100] [Job 55] argv[1]="55"
D [02/Dec/2013:15:35:10 +0100] [Job 55] argv[2]="admin"
D [02/Dec/2013:15:35:10 +0100] [Job 55] argv[3]="printers.pdf"
D [02/Dec/2013:15:35:10 +0100] [Job 55] argv[4]="1"
D [02/Dec/2013:15:35:10 +0100] [Job 55] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:50e1461b-6ca2-3465-4949-01d005af02e8 job-originating-host-name=localhost time-at-creation=1385994910 time-at-processing=1385994910"
D [02/Dec/2013:15:35:10 +0100] [Job 55] argv[6]="/var/spool/cups/d00055-001"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[7]="CUPS_STATEDIR=/run/cups"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[8]="HOME=/var/spool/cups/tmp"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[10]="SERVER_ADMIN=root@jack"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[11]="SOFTWARE=CUPS/1.7.0"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[13]="USER=root"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[14]="CUPS_MAX_MESSAGE=2047"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[15]="CUPS_SERVER=/run/cups/cups.sock"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[17]="IPP_PORT=631"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[18]="CHARSET=utf-8"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[19]="LANG=en_US.UTF-8"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[20]="PPD=/etc/cups/ppd/bj.ppd"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[21]="RIP_MAX_CACHE=128m"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[22]="CONTENT_TYPE=application/pdf"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[23]="DEVICE_URI=usb://Brother/HL-2030%20series?serial=D7J580621"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[24]="PRINTER_INFO=Brother HL-2030 series"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[25]="PRINTER_LOCATION=jack"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[26]="PRINTER=bj"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[27]="PRINTER_STATE_REASONS=none"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[28]="CUPS_FILETYPE=document"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[29]="FINAL_CONTENT_TYPE=printer/bj"
D [02/Dec/2013:15:35:10 +0100] [Job 55] envp[30]="AUTH_I****"
I [02/Dec/2013:15:35:10 +0100] [Job 55] Started filter /usr/lib/cups/filter/pdftopdf (PID 7208)
I [02/Dec/2013:15:35:10 +0100] [Job 55] Started filter /usr/lib/cups/filter/foomatic-rip (PID 7209)
I [02/Dec/2013:15:35:10 +0100] [Job 55] Started backend /usr/lib/cups/backend/usb (PID 7210)
D [02/Dec/2013:15:35:10 +0100] [Job 55] Getting input from file
D [02/Dec/2013:15:35:10 +0100] [Job 55] foomatic-rip version 4.0.17.256 running...
D [02/Dec/2013:15:35:10 +0100] [Job 55] Parsing PPD file ...
D [02/Dec/2013:15:35:10 +0100] [Job 55] Added option ColorSpace
D [02/Dec/2013:15:35:10 +0100] [Job 55] Added option PageSize
D [02/Dec/2013:15:35:10 +0100] [Job 55] Added option ImageableArea
D [02/Dec/2013:15:35:10 +0100] [Job 55] Added option PaperDimension
D [02/Dec/2013:15:35:10 +0100] [Job 55] Added option EconoMode
D [02/Dec/2013:15:35:10 +0100] [Job 55] Added option InputSlot
D [02/Dec/2013:15:35:10 +0100] [Job 55] Added option Resolution
D [02/Dec/2013:15:35:10 +0100] [Job 55] Added option MediaType
D [02/Dec/2013:15:35:10 +0100] [Job 55] Added option HalftoningAlgorithm
D [02/Dec/2013:15:35:10 +0100] [Job 55] Loading USB quirks from "/usr/share/cups/usb".
D [02/Dec/2013:15:35:10 +0100] [Job 55] Loaded 67 quirks.
D [02/Dec/2013:15:35:10 +0100] [Job 55] Added option Font
D [02/Dec/2013:15:35:10 +0100] [Job 55] Printing on printer with URI: usb://Brother/HL-2030%20series?serial=D7J580621
D [02/Dec/2013:15:35:10 +0100] [Job 55] libusb_get_device_list=4
D [02/Dec/2013:15:35:10 +0100] [Job 55] Parameter Summary
D [02/Dec/2013:15:35:10 +0100] [Job 55] -----------------
D [02/Dec/2013:15:35:10 +0100] [Job 55] Spooler: cups
D [02/Dec/2013:15:35:10 +0100] [Job 55] Printer: bj
D [02/Dec/2013:15:35:10 +0100] [Job 55] Shell: /bin/bash
D [02/Dec/2013:15:35:10 +0100] [Job 55] PPD file: /etc/cups/ppd/bj.ppd
D [02/Dec/2013:15:35:10 +0100] [Job 55] ATTR file:
D [02/Dec/2013:15:35:10 +0100] [Job 55] Printer model: Brother HL-2030 Foomatic/hl1250 (recommended)
D [02/Dec/2013:15:35:10 +0100] [Job 55] Job title: printers.pdf
D [02/Dec/2013:15:35:10 +0100] [Job 55] File(s) to be printed:
D [02/Dec/2013:15:35:10 +0100] [Job 55] <STDIN>
D [02/Dec/2013:15:35:10 +0100] [Job 55] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [02/Dec/2013:15:35:10 +0100] [Job 55] Printing system options:
D [02/Dec/2013:15:35:10 +0100] [Job 55] Pondering option 'finishings=3'
D [02/Dec/2013:15:35:10 +0100] [Job 55] Unknown option finishings=3.
D [02/Dec/2013:15:35:10 +0100] [Job 55] Pondering option 'number-up=1'
D [02/Dec/2013:15:35:10 +0100] [Job 55] Unknown option number-up=1.
D [02/Dec/2013:15:35:10 +0100] [Job 55] Pondering option 'job-uuid=urn:uuid:50e1461b-6ca2-3465-4949-01d005af02e8'
D [02/Dec/2013:15:35:10 +0100] [Job 55] Unknown option job-uuid=urn:uuid:50e1461b-6ca2-3465-4949-01d005af02e8.
D [02/Dec/2013:15:35:10 +0100] [Job 55] Pondering option 'job-originating-host-name=localhost'
D [02/Dec/2013:15:35:10 +0100] [Job 55] Unknown option job-originating-host-name=localhost.
D [02/Dec/2013:15:35:10 +0100] [Job 55] Pondering option 'time-at-creation=1385994910'
D [02/Dec/2013:15:35:10 +0100] [Job 55] Unknown option time-at-creation=1385994910.
D [02/Dec/2013:15:35:10 +0100] [Job 55] Pondering option 'time-at-processing=1385994910'
D [02/Dec/2013:15:35:10 +0100] [Job 55] Unknown option time-at-processing=1385994910.
D [02/Dec/2013:15:35:10 +0100] [Job 55] Options from the PPD file:
D [02/Dec/2013:15:35:10 +0100] [Job 55] ================================================
D [02/Dec/2013:15:35:10 +0100] [Job 55] File: <STDIN>
D [02/Dec/2013:15:35:10 +0100] [Job 55] ================================================
D [02/Dec/2013:15:35:10 +0100] [Job 55] STATE: +connecting-to-device
D [02/Dec/2013:15:35:10 +0100] [Job 55] STATE: -connecting-to-device
D [02/Dec/2013:15:35:10 +0100] [Job 55] Device protocol: 2
I [02/Dec/2013:15:35:10 +0100] [Job 55] Sending data to printer.
D [02/Dec/2013:15:35:10 +0100] [Job 55] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [02/Dec/2013:15:35:10 +0100] [Job 55] Filetype: PDF
D [02/Dec/2013:15:35:10 +0100] [Job 55] Storing temporary files in /var/spool/cups/tmp
D [02/Dec/2013:15:35:10 +0100] [Job 55] PID 7208 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [02/Dec/2013:15:35:11 +0100] [Job 55] File contains 1 pages
D [02/Dec/2013:15:35:11 +0100] [Job 55] Starting renderer with command: gs -dFirstPage=1 -q -dBATCH -dPARANOIDSAFER -dNOPAUSE -sDEVICE=hl1250 -dEconoMode=0 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -r600x600 -dSourceTray=0 -dPaperType=0 -sOutputFile=- -c '/Default << /SpotFunction { 180 mul cos exch 180 mul cos add 2 div } bind /HalftoneType 1 /AccurateScreens true /Frequency 137 /Angle 37 /HalftoneName (Round Dot Screen) >> /Halftone defineresource sethalftone << /HalftoneMode 1 /UseWTS false /AccurateScreens true >> setuserparams' -f /var/spool/cups/tmp/foomatic-bNnORB
D [02/Dec/2013:15:35:11 +0100] [Job 55] Starting process "kid3" (generation 1)
D [02/Dec/2013:15:35:11 +0100] [Job 55] Starting process "kid4" (generation 2)
D [02/Dec/2013:15:35:11 +0100] [Job 55] Starting process "renderer" (generation 2)
D [02/Dec/2013:15:35:11 +0100] [Job 55] JCL: 2345X@PJL
D [02/Dec/2013:15:35:11 +0100] [Job 55] <job data>
')
If I convert the file to the language of the printer and send it raw
$ gs -q -dNOPAUSE -dBATCH -dSAFER -sDEVICE=hl1250 -sOutputFile=\|"lpr -o raw" printers.conf.ps
the page is printed.
Here the cups’s error_log
$this->bbcode_second_pass_code('', '
I [02/Dec/2013:15:32:34 +0100] [Job 54] Adding start banner page "none".
I [02/Dec/2013:15:32:34 +0100] [Job 54] Queued on "bj" by "admin".
I [02/Dec/2013:15:32:34 +0100] [Job 54] File of type application/vnd.cups-raw queued by "admin".
I [02/Dec/2013:15:32:34 +0100] [Job 54] Adding end banner page "none".
D [02/Dec/2013:15:32:34 +0100] [Job 54] time-at-processing=1385994754
D [02/Dec/2013:15:32:34 +0100] [Job 54] 2 filters for job:
D [02/Dec/2013:15:32:34 +0100] [Job 54] - (application/vnd.cups-raw to printer/bj/application/octet-stream, cost 0)
D [02/Dec/2013:15:32:34 +0100] [Job 54] - (printer/bj/application/octet-stream to printer/bj, cost 0)
D [02/Dec/2013:15:32:34 +0100] [Job 54] job-sheets=none,none
D [02/Dec/2013:15:32:34 +0100] [Job 54] argv[0]="bj"
D [02/Dec/2013:15:32:34 +0100] [Job 54] argv[1]="54"
D [02/Dec/2013:15:32:34 +0100] [Job 54] argv[2]="admin"
D [02/Dec/2013:15:32:34 +0100] [Job 54] argv[3]="prnt.hl"
D [02/Dec/2013:15:32:34 +0100] [Job 54] argv[4]="1"
D [02/Dec/2013:15:32:34 +0100] [Job 54] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:6454d51c-b12b-33be-6a5e-c131a4ff2887 job-originating-host-name=localhost time-at-creation=1385994754 time-at-processing=1385994754"
D [02/Dec/2013:15:32:34 +0100] [Job 54] argv[6]="/var/spool/cups/d00054-001"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[7]="CUPS_STATEDIR=/run/cups"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[8]="HOME=/var/spool/cups/tmp"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[10]="SERVER_ADMIN=root@jack"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[11]="SOFTWARE=CUPS/1.7.0"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[13]="USER=root"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[14]="CUPS_MAX_MESSAGE=2047"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[15]="CUPS_SERVER=/run/cups/cups.sock"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[17]="IPP_PORT=631"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[18]="CHARSET=utf-8"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[19]="LANG=en_US.UTF-8"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[20]="PPD=/etc/cups/ppd/bj.ppd"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[21]="RIP_MAX_CACHE=128m"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[22]="CONTENT_TYPE=application/vnd.cups-raw"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[23]="DEVICE_URI=usb://Brother/HL-2030%20series?serial=D7J580621"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[24]="PRINTER_INFO=Brother HL-2030 series"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[25]="PRINTER_LOCATION=jack"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[26]="PRINTER=bj"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[27]="PRINTER_STATE_REASONS=none"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[28]="CUPS_FILETYPE=document"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[29]="FINAL_CONTENT_TYPE=printer/bj"
D [02/Dec/2013:15:32:34 +0100] [Job 54] envp[30]="AUTH_I****"
I [02/Dec/2013:15:32:34 +0100] [Job 54] Started backend /usr/lib/cups/backend/usb (PID 7201)
D [02/Dec/2013:15:32:34 +0100] [Job 54] Loading USB quirks from "/usr/share/cups/usb".
D [02/Dec/2013:15:32:34 +0100] [Job 54] Loaded 67 quirks.
D [02/Dec/2013:15:32:34 +0100] [Job 54] Printing on printer with URI: usb://Brother/HL-2030%20series?serial=D7J580621
D [02/Dec/2013:15:32:34 +0100] [Job 54] libusb_get_device_list=4
D [02/Dec/2013:15:32:34 +0100] [Job 54] STATE: +connecting-to-device
D [02/Dec/2013:15:32:34 +0100] [Job 54] STATE: -connecting-to-device
D [02/Dec/2013:15:32:34 +0100] [Job 54] Device protocol: 2
I [02/Dec/2013:15:32:34 +0100] [Job 54] Sending data to printer.
D [02/Dec/2013:15:32:34 +0100] [Job 54] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [02/Dec/2013:15:32:34 +0100] [Job 54] PAGE: 1 1
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 8192 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 16384 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 24576 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 32768 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 40960 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 49152 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 57344 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 65536 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 73728 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 81920 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 90112 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 98304 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 106496 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 114688 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 122880 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 8192 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 131072 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Read 5788 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Wrote 5788 bytes of print data...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sending print file, 136860 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Sent 136860 bytes...
D [02/Dec/2013:15:32:34 +0100] [Job 54] Waiting for read thread to exit...
D [02/Dec/2013:15:32:34 +0100] [Job 54] PID 7201 (/usr/lib/cups/backend/usb) exited with no errors.
D [02/Dec/2013:15:32:34 +0100] [Job 54] time-at-completed=1385994754
I [02/Dec/2013:15:32:34 +0100] [Job 54] Job completed.
D [02/Dec/2013:15:32:35 +0100] [Job 54] Unloading...
')
Maybe a problem with foomatic-rip, ghostscript, cups filters?
What else?
Any help welcome.

by **Geoff** » Tue Dec 03, 2013 2:15 am

Some of those filters require a whole lot of RAM. I find it convenient to configure my client devices (e.g., laptop) to print remotely using a local filter to send printer-ready raw data.

by **pepedog** » Tue Dec 03, 2013 8:41 am

Coincidence that I only just got my HL2030 working recently.
On an odroid U2, quad core 2 Gb ram, all works
NSA 320, Windows works fine, AirPrint (using GS) takes all CPU for ages before I kill it

by **WarheadsSE** » Tue Dec 03, 2013 1:31 pm

Compare the NSA320 to the Odroid U2.

- 1x 1.2Ghz armv5te, no floating point, 512MB
- 4x 1.7 armv7h, neon, vfpv3, 2GB

Yeah.. not much wonder there. Windows can send PCL/PCF and not ghostscript/postscript, which is a much heavier spec mathematically.

by **icy6210** » Tue Dec 03, 2013 10:51 pm

I don't think is a RAM or processor problem this Icybox worked perfectly as backup device and print server with Archlinuxarm before systemd. No raw queue but processing and rendering everything.
Actually, tonight I have configured my client pc to process the files and the server to print raw input, but the printer vomit tons of white pages. The logs of cups, client and server side tells that everything is ok.
Client side error_log
$this->bbcode_second_pass_code('', '
I [03/Dec/2013:22:43:31 +0100] [Job 37] Adding start banner page "none".
I [03/Dec/2013:22:43:31 +0100] [Job 37] Queued on "2030" by "nolby".
D [03/Dec/2013:22:43:31 +0100] [Job 37] Auto-typing file...
D [03/Dec/2013:22:43:31 +0100] [Job 37] Request file type is text/plain.
I [03/Dec/2013:22:43:31 +0100] [Job 37] File of type text/plain queued by "nolby".
I [03/Dec/2013:22:43:31 +0100] [Job 37] Adding end banner page "none".
D [03/Dec/2013:22:43:31 +0100] [Job 37] time-at-processing=1386107011
D [03/Dec/2013:22:43:31 +0100] [Job 37] 3 filters for job:
D [03/Dec/2013:22:43:31 +0100] [Job 37] texttopdf (text/plain to application/pdf, cost 32)
D [03/Dec/2013:22:43:31 +0100] [Job 37] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [03/Dec/2013:22:43:31 +0100] [Job 37] foomatic-rip (application/vnd.cups-pdf to printer/2030, cost 0)
D [03/Dec/2013:22:43:31 +0100] [Job 37] job-sheets=none,none
D [03/Dec/2013:22:43:31 +0100] [Job 37] argv[0]="2030"
D [03/Dec/2013:22:43:31 +0100] [Job 37] argv[1]="37"
D [03/Dec/2013:22:43:31 +0100] [Job 37] argv[2]="nolby"
D [03/Dec/2013:22:43:31 +0100] [Job 37] argv[3]="11-bakup-hard-disc.rules"
D [03/Dec/2013:22:43:31 +0100] [Job 37] argv[4]="1"
D [03/Dec/2013:22:43:31 +0100] [Job 37] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:55d46708-e538-3541-4165-9824349cc047 job-originating-host-name=localhost time-at-creation=1386107011 time-at-processing=1386107011"
D [03/Dec/2013:22:43:31 +0100] [Job 37] argv[6]="/var/spool/cups/d00037-001"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[7]="CUPS_STATEDIR=/run/cups"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[8]="HOME=/var/spool/cups/tmp"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[10]="SERVER_ADMIN=root@boomerang"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[11]="SOFTWARE=CUPS/1.7.0"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[13]="USER=root"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[14]="CUPS_MAX_MESSAGE=2047"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[17]="IPP_PORT=631"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[18]="CHARSET=utf-8"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[19]="LANG=en_US.UTF-8"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[20]="PPD=/etc/cups/ppd/2030.ppd"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[21]="RIP_MAX_CACHE=128m"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[22]="CONTENT_TYPE=text/plain"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[23]="DEVICE_URI=ipp://192.168.11.2:631/printers/bj"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[24]="PRINTER_INFO=Brother HL-2030 series"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[25]="PRINTER_LOCATION=Stanza Giulio"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[26]="PRINTER=2030"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[27]="PRINTER_STATE_REASONS=cups-ipp-conformance-failure-report,cups-ipp-missing-job-history"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[28]="CUPS_FILETYPE=document"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[29]="FINAL_CONTENT_TYPE=printer/2030"
D [03/Dec/2013:22:43:31 +0100] [Job 37] envp[30]="AUTH_I****"
I [03/Dec/2013:22:43:31 +0100] [Job 37] Started filter /usr/lib/cups/filter/texttopdf (PID 31730)
I [03/Dec/2013:22:43:31 +0100] [Job 37] Started filter /usr/lib/cups/filter/pdftopdf (PID 31731)
I [03/Dec/2013:22:43:31 +0100] [Job 37] Started filter /usr/lib/cups/filter/foomatic-rip (PID 31732)
I [03/Dec/2013:22:43:31 +0100] [Job 37] Started backend /usr/lib/cups/backend/ipp (PID 31733)
D [03/Dec/2013:22:43:31 +0100] [Job 37] Page = 595x842; 18,36 to 577,806
D [03/Dec/2013:22:43:31 +0100] [Job 37] Getting input from file
D [03/Dec/2013:22:43:31 +0100] [Job 37] foomatic-rip version 4.0.17.256 running...
D [03/Dec/2013:22:43:31 +0100] [Job 37] Parsing PPD file ...
D [03/Dec/2013:22:43:31 +0100] [Job 37] Added option ColorSpace
D [03/Dec/2013:22:43:31 +0100] [Job 37] Added option PageSize
D [03/Dec/2013:22:43:31 +0100] [Job 37] Added option ImageableArea
D [03/Dec/2013:22:43:31 +0100] [Job 37] Added option PaperDimension
D [03/Dec/2013:22:43:31 +0100] [Job 37] Added option EconoMode
D [03/Dec/2013:22:43:31 +0100] [Job 37] Added option InputSlot
D [03/Dec/2013:22:43:31 +0100] [Job 37] Sending stdin for job...
D [03/Dec/2013:22:43:31 +0100] [Job 37] update_reasons(attr=0(), s="+connecting-to-device")
D [03/Dec/2013:22:43:31 +0100] [Job 37] STATE: +connecting-to-device
D [03/Dec/2013:22:43:31 +0100] [Job 37] Looking up "192.168.11.2"...
D [03/Dec/2013:22:43:31 +0100] [Job 37] Added option Resolution
D [03/Dec/2013:22:43:31 +0100] [Job 37] Added option MediaType
D [03/Dec/2013:22:43:31 +0100] [Job 37] Added option HalftoningAlgorithm
D [03/Dec/2013:22:43:31 +0100] [Job 37] Added option Font
D [03/Dec/2013:22:43:31 +0100] [Job 37] Parameter Summary
D [03/Dec/2013:22:43:31 +0100] [Job 37] -----------------
D [03/Dec/2013:22:43:31 +0100] [Job 37] Spooler: cups
D [03/Dec/2013:22:43:31 +0100] [Job 37] Printer: 2030
D [03/Dec/2013:22:43:31 +0100] [Job 37] Shell: /bin/bash
D [03/Dec/2013:22:43:31 +0100] [Job 37] PPD file: /etc/cups/ppd/2030.ppd
D [03/Dec/2013:22:43:31 +0100] [Job 37] ATTR file:
D [03/Dec/2013:22:43:31 +0100] [Job 37] Printer model: Brother HL-2030 Foomatic/hl1250 (recommended)
D [03/Dec/2013:22:43:31 +0100] [Job 37] Job title: 11-bakup-hard-disc.rules
D [03/Dec/2013:22:43:31 +0100] [Job 37] File(s) to be printed:
D [03/Dec/2013:22:43:31 +0100] [Job 37] <STDIN>
D [03/Dec/2013:22:43:31 +0100] [Job 37] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [03/Dec/2013:22:43:31 +0100] [Job 37] Printing system options:
D [03/Dec/2013:22:43:31 +0100] [Job 37] Pondering option 'finishings=3'
D [03/Dec/2013:22:43:31 +0100] [Job 37] Unknown option finishings=3.
D [03/Dec/2013:22:43:31 +0100] [Job 37] Pondering option 'number-up=1'
D [03/Dec/2013:22:43:31 +0100] [Job 37] Unknown option number-up=1.
D [03/Dec/2013:22:43:31 +0100] [Job 37] Pondering option 'job-uuid=urn:uuid:55d46708-e538-3541-4165-9824349cc047'
D [03/Dec/2013:22:43:31 +0100] [Job 37] Unknown option job-uuid=urn:uuid:55d46708-e538-3541-4165-9824349cc047.
D [03/Dec/2013:22:43:31 +0100] [Job 37] Pondering option 'job-originating-host-name=localhost'
D [03/Dec/2013:22:43:31 +0100] [Job 37] Unknown option job-originating-host-name=localhost.
D [03/Dec/2013:22:43:31 +0100] [Job 37] Pondering option 'time-at-creation=1386107011'
D [03/Dec/2013:22:43:31 +0100] [Job 37] Unknown option time-at-creation=1386107011.
D [03/Dec/2013:22:43:31 +0100] [Job 37] Pondering option 'time-at-processing=1386107011'
D [03/Dec/2013:22:43:31 +0100] [Job 37] Unknown option time-at-processing=1386107011.
D [03/Dec/2013:22:43:31 +0100] [Job 37] Options from the PPD file:
D [03/Dec/2013:22:43:31 +0100] [Job 37] ================================================
D [03/Dec/2013:22:43:31 +0100] [Job 37] File: <STDIN>
D [03/Dec/2013:22:43:31 +0100] [Job 37] ================================================
D [03/Dec/2013:22:43:31 +0100] [Job 37] PID 31730 (/usr/lib/cups/filter/texttopdf) exited with no errors.
D [03/Dec/2013:22:43:31 +0100] [Job 37] Filetype: PDF
D [03/Dec/2013:22:43:31 +0100] [Job 37] Storing temporary files in /var/spool/cups/tmp
D [03/Dec/2013:22:43:31 +0100] [Job 37] PID 31731 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [03/Dec/2013:22:43:31 +0100] [Job 37] File contains 1 pages
D [03/Dec/2013:22:43:31 +0100] [Job 37] Starting renderer with command: gs -dFirstPage=1 -q -dBATCH -dPARANOIDSAFER -dNOPAUSE -sDEVICE=hl1250 -dEconoMode=0 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -r600x600 -dSourceTray=0 -dPaperType=0 -sOutputFile=- -c '/Default << /SpotFunction { 180 mul cos exch 180 mul cos add 2 div } bind /HalftoneType 1 /AccurateScreens true /Frequency 137 /Angle 37 /HalftoneName (Round Dot Screen) >> /Halftone defineresource sethalftone << /HalftoneMode 1 /UseWTS false /AccurateScreens true >> setuserparams' -f /var/spool/cups/tmp/foomatic-qZ7LKl
D [03/Dec/2013:22:43:31 +0100] [Job 37] Starting process "kid3" (generation 1)
D [03/Dec/2013:22:43:31 +0100] [Job 37] Starting process "kid4" (generation 2)
D [03/Dec/2013:22:43:31 +0100] [Job 37] Starting process "renderer" (generation 2)
D [03/Dec/2013:22:43:31 +0100] [Job 37] JCL: -12345X@PJL
D [03/Dec/2013:22:43:31 +0100] [Job 37] <job data>
D [03/Dec/2013:22:43:32 +0100] [Job 37] renderer exited with status 0
D [03/Dec/2013:22:43:32 +0100] [Job 37] kid4 exited with status 0
D [03/Dec/2013:22:43:32 +0100] [Job 37] kid3 finished
D [03/Dec/2013:22:43:32 +0100] [Job 37] Kid3 exit status: 0
D [03/Dec/2013:22:43:32 +0100] [Job 37] Closing foomatic-rip.
D [03/Dec/2013:22:43:32 +0100] [Job 37] PID 31732 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.
D [03/Dec/2013:22:43:35 +0100] [Job 37] prtGeneralCurrentLocalization type is 0, expected 2!
D [03/Dec/2013:22:43:35 +0100] [Job 37] backendWaitLoop(snmp_fd=6, addr=0x7fa18cb72ab8, side_cb=0x7fa18bee28e0)
D [03/Dec/2013:22:43:35 +0100] [Job 37] Connecting to 192.168.11.2:631
I [03/Dec/2013:22:43:35 +0100] [Job 37] Connecting to printer.
D [03/Dec/2013:22:43:35 +0100] [Job 37] Set job-printer-state-message to "Connecting to printer.", current level=INFO
D [03/Dec/2013:22:43:35 +0100] [Job 37] update_reasons(attr=0(), s="-cups-certificate-error")
D [03/Dec/2013:22:43:35 +0100] [Job 37] update_reasons(attr=0(), s="-connecting-to-device")
D [03/Dec/2013:22:43:35 +0100] [Job 37] STATE: -connecting-to-device
I [03/Dec/2013:22:43:35 +0100] [Job 37] Connected to printer.
D [03/Dec/2013:22:43:35 +0100] [Job 37] Set job-printer-state-message to "Connected to printer.", current level=INFO
D [03/Dec/2013:22:43:35 +0100] [Job 37] Connected to 192.168.11.2:631...
D [03/Dec/2013:22:43:35 +0100] [Job 37] Getting supported attributes...
D [03/Dec/2013:22:43:35 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:35 +0100] [Job 37] Automatically using "gzip" compression.
D [03/Dec/2013:22:43:35 +0100] [Job 37] copies-supported=1-9999
D [03/Dec/2013:22:43:35 +0100] [Job 37] document-format-supported (39 values)
D [03/Dec/2013:22:43:35 +0100] [Job 37] [0] = "application/octet-stream"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [1] = "application/pdf"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [2] = "application/postscript"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [3] = "application/rss+xml"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [4] = "application/vnd.adobe-reader-postscript"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [5] = "application/vnd.cups-banner"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [6] = "application/vnd.cups-command"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [7] = "application/vnd.cups-pdf"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [8] = "application/vnd.cups-pdf-banner"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [9] = "application/vnd.cups-postscript"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [10] = "application/vnd.cups-ppd"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [11] = "application/vnd.cups-raster"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [12] = "application/vnd.cups-raw"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [13] = "application/x-cshell"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [14] = "application/x-csource"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [15] = "application/x-perl"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [16] = "application/x-shell"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [17] = "image/gif"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [18] = "image/jpeg"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [19] = "image/png"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [20] = "image/pwg-raster"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [21] = "image/tiff"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [22] = "image/urf"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [23] = "image/x-alias"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [24] = "image/x-bitmap"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [25] = "image/x-icon"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [26] = "image/x-photocd"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [27] = "image/x-portable-anymap"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [28] = "image/x-portable-bitmap"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [29] = "image/x-portable-graymap"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [30] = "image/x-portable-pixmap"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [31] = "image/x-sgi-rgb"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [32] = "image/x-sun-raster"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [33] = "image/x-xbitmap"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [34] = "image/x-xpixmap"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [35] = "image/x-xwindowdump"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [36] = "text/css"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [37] = "text/html"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [38] = "text/plain"
D [03/Dec/2013:22:43:35 +0100] [Job 37] media-col-supported (7 values)
D [03/Dec/2013:22:43:35 +0100] [Job 37] [0] = "media-bottom-margin"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [1] = "media-left-margin"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [2] = "media-right-margin"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [3] = "media-size"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [4] = "media-source"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [5] = "media-top-margin"
D [03/Dec/2013:22:43:35 +0100] [Job 37] [6] = "media-type"
D [03/Dec/2013:22:43:35 +0100] [Job 37] operations-supported (48 values)
D [03/Dec/2013:22:43:35 +0100] [Job 37] [0] = Print-Job
D [03/Dec/2013:22:43:35 +0100] [Job 37] [1] = Validate-Job
D [03/Dec/2013:22:43:35 +0100] [Job 37] [2] = Create-Job
D [03/Dec/2013:22:43:35 +0100] [Job 37] [3] = Send-Document
D [03/Dec/2013:22:43:35 +0100] [Job 37] [4] = Cancel-Job
D [03/Dec/2013:22:43:35 +0100] [Job 37] [5] = Get-Job-Attributes
D [03/Dec/2013:22:43:35 +0100] [Job 37] [6] = Get-Jobs
D [03/Dec/2013:22:43:35 +0100] [Job 37] [7] = Get-Printer-Attributes
D [03/Dec/2013:22:43:35 +0100] [Job 37] [8] = Hold-Job
D [03/Dec/2013:22:43:35 +0100] [Job 37] [9] = Release-Job
D [03/Dec/2013:22:43:35 +0100] [Job 37] [10] = Restart-Job
D [03/Dec/2013:22:43:35 +0100] [Job 37] [11] = Pause-Printer
D [03/Dec/2013:22:43:35 +0100] [Job 37] [12] = Resume-Printer
D [03/Dec/2013:22:43:35 +0100] [Job 37] [13] = Purge-Jobs
D [03/Dec/2013:22:43:35 +0100] [Job 37] [14] = Set-Printer-Attributes
D [03/Dec/2013:22:43:35 +0100] [Job 37] [15] = Set-Job-Attributes
D [03/Dec/2013:22:43:35 +0100] [Job 37] [16] = Get-Printer-Supported-Values
D [03/Dec/2013:22:43:35 +0100] [Job 37] [17] = Create-Printer-Subscription
D [03/Dec/2013:22:43:35 +0100] [Job 37] [18] = Create-Job-Subscription
D [03/Dec/2013:22:43:35 +0100] [Job 37] [19] = Get-Subscription-Attributes
D [03/Dec/2013:22:43:35 +0100] [Job 37] [20] = Get-Subscriptions
D [03/Dec/2013:22:43:35 +0100] [Job 37] [21] = Renew-Subscription
D [03/Dec/2013:22:43:35 +0100] [Job 37] [22] = Cancel-Subscription
D [03/Dec/2013:22:43:35 +0100] [Job 37] [23] = Get-Notifications
D [03/Dec/2013:22:43:35 +0100] [Job 37] [24] = Enable-Printer
D [03/Dec/2013:22:43:35 +0100] [Job 37] [25] = Disable-Printer
D [03/Dec/2013:22:43:35 +0100] [Job 37] [26] = Hold-New-Jobs
D [03/Dec/2013:22:43:35 +0100] [Job 37] [27] = Release-Held-New-Jobs
D [03/Dec/2013:22:43:35 +0100] [Job 37] [28] = Cancel-Jobs
D [03/Dec/2013:22:43:35 +0100] [Job 37] [29] = Cancel-My-Jobs
D [03/Dec/2013:22:43:35 +0100] [Job 37] [30] = Close-Job
D [03/Dec/2013:22:43:35 +0100] [Job 37] [31] = CUPS-Get-Default
D [03/Dec/2013:22:43:35 +0100] [Job 37] [32] = CUPS-Get-Printers
D [03/Dec/2013:22:43:35 +0100] [Job 37] [33] = CUPS-Add-Modify-Printer
D [03/Dec/2013:22:43:35 +0100] [Job 37] [34] = CUPS-Delete-Printer
D [03/Dec/2013:22:43:35 +0100] [Job 37] [35] = CUPS-Get-Classes
D [03/Dec/2013:22:43:35 +0100] [Job 37] [36] = CUPS-Add-Modify-Class
D [03/Dec/2013:22:43:35 +0100] [Job 37] [37] = CUPS-Delete-Class
D [03/Dec/2013:22:43:35 +0100] [Job 37] [38] = CUPS-Accept-Jobs
D [03/Dec/2013:22:43:35 +0100] [Job 37] [39] = CUPS-Reject-Jobs
D [03/Dec/2013:22:43:35 +0100] [Job 37] [40] = CUPS-Set-Default
D [03/Dec/2013:22:43:35 +0100] [Job 37] [41] = CUPS-Get-Devices
D [03/Dec/2013:22:43:35 +0100] [Job 37] [42] = CUPS-Get-PPDs
D [03/Dec/2013:22:43:35 +0100] [Job 37] [43] = CUPS-Move-Job
D [03/Dec/2013:22:43:35 +0100] [Job 37] [44] = CUPS-Authenticate-Job
D [03/Dec/2013:22:43:35 +0100] [Job 37] [45] = CUPS-Get-PPD
D [03/Dec/2013:22:43:35 +0100] [Job 37] [46] = CUPS-Get-Document
D [03/Dec/2013:22:43:35 +0100] [Job 37] [47] = Restart-Job
I [03/Dec/2013:22:43:35 +0100] [Job 37] Unable to send data to printer.
D [03/Dec/2013:22:43:35 +0100] [Job 37] Set job-printer-state-message to "Unable to send data to printer.", current level=INFO
D [03/Dec/2013:22:43:35 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:35 +0100] [Job 37] final_content_type="printer/2030", document_format="application/octet-stream"
D [03/Dec/2013:22:43:35 +0100] [Job 37] Validate-Job IPP/2.0
D [03/Dec/2013:22:43:35 +0100] [Job 37] printer-uri="ipp://192.168.11.2:631/printers/bj"
D [03/Dec/2013:22:43:35 +0100] [Job 37] requesting-user-name="nolby"
D [03/Dec/2013:22:43:35 +0100] [Job 37] job-name="11-bakup-hard-disc.rules"
D [03/Dec/2013:22:43:35 +0100] [Job 37] document-format="application/octet-stream"
D [03/Dec/2013:22:43:35 +0100] [Job 37] IPP/2.0 Validate-Job #2
D [03/Dec/2013:22:43:35 +0100] [Job 37] ---- operation-attributes-tag ----
D [03/Dec/2013:22:43:35 +0100] [Job 37] attributes-charset charset utf-8
D [03/Dec/2013:22:43:35 +0100] [Job 37] attributes-natural-language naturalLanguage en-us
D [03/Dec/2013:22:43:35 +0100] [Job 37] printer-uri uri ipp://192.168.11.2:631/printers/bj
D [03/Dec/2013:22:43:35 +0100] [Job 37] requesting-user-name nameWithoutLanguage nolby
D [03/Dec/2013:22:43:35 +0100] [Job 37] job-name nameWithoutLanguage 11-bakup-hard-disc.rules
D [03/Dec/2013:22:43:35 +0100] [Job 37] document-format mimeMediaType application/octet-stream
D [03/Dec/2013:22:43:35 +0100] [Job 37] ---- end-of-attributes-tag ----
D [03/Dec/2013:22:43:35 +0100] [Job 37] Validate-Job: successful-ok (successful-ok)
D [03/Dec/2013:22:43:35 +0100] [Job 37] Create-Job IPP/2.0
D [03/Dec/2013:22:43:35 +0100] [Job 37] printer-uri="ipp://192.168.11.2:631/printers/bj"
D [03/Dec/2013:22:43:35 +0100] [Job 37] requesting-user-name="nolby"
D [03/Dec/2013:22:43:35 +0100] [Job 37] job-name="11-bakup-hard-disc.rules"
D [03/Dec/2013:22:43:35 +0100] [Job 37] IPP/2.0 Create-Job #4
D [03/Dec/2013:22:43:35 +0100] [Job 37] ---- operation-attributes-tag ----
D [03/Dec/2013:22:43:35 +0100] [Job 37] attributes-charset charset utf-8
D [03/Dec/2013:22:43:35 +0100] [Job 37] attributes-natural-language naturalLanguage en-us
D [03/Dec/2013:22:43:35 +0100] [Job 37] printer-uri uri ipp://192.168.11.2:631/printers/bj
D [03/Dec/2013:22:43:35 +0100] [Job 37] requesting-user-name nameWithoutLanguage nolby
D [03/Dec/2013:22:43:35 +0100] [Job 37] job-name nameWithoutLanguage 11-bakup-hard-disc.rules
D [03/Dec/2013:22:43:35 +0100] [Job 37] ---- end-of-attributes-tag ----
I [03/Dec/2013:22:43:35 +0100] [Job 37] Unable to send data to printer.
D [03/Dec/2013:22:43:35 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:35 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:35 +0100] [Job 37] Create-Job: successful-ok (successful-ok)
D [03/Dec/2013:22:43:35 +0100] [Job 37] Print job accepted - job ID 70.
D [03/Dec/2013:22:43:35 +0100] [Job 37] Sending file 1 using chunking...
D [03/Dec/2013:22:43:35 +0100] [Job 37] (monitor) Get-Jobs: successful-ok (successful-ok)
D [03/Dec/2013:22:43:35 +0100] [Job 37] (monitor) job-state=pending-held
D [03/Dec/2013:22:43:35 +0100] [Job 37] Send-Document: successful-ok (successful-ok)
I [03/Dec/2013:22:43:35 +0100] [Job 37] Waiting for job to complete.
D [03/Dec/2013:22:43:35 +0100] [Job 37] Set job-printer-state-message to "Waiting for job to complete.", current level=INFO
D [03/Dec/2013:22:43:35 +0100] [Job 37] Set job-printer-state-message to "Waiting for job to complete.", current level=INFO
D [03/Dec/2013:22:43:35 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:35 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:35 +0100] [Job 37] Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:35 +0100] [Job 37] update_reasons(attr=0(), s="+cups-remote-processing")
D [03/Dec/2013:22:43:35 +0100] [Job 37] STATE: +cups-remote-processing
D [03/Dec/2013:22:43:35 +0100] [Job 37] PAGE: total 0
I [03/Dec/2013:22:43:36 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:36 +0100] [Job 37] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [03/Dec/2013:22:43:36 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:36 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:36 +0100] [Job 37] (monitor) Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:36 +0100] [Job 37] (monitor) job-state=processing
I [03/Dec/2013:22:43:36 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:36 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:36 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:36 +0100] [Job 37] Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:36 +0100] [Job 37] update_reasons(attr=0(), s="+cups-remote-processing")
D [03/Dec/2013:22:43:36 +0100] [Job 37] PAGE: total 1
I [03/Dec/2013:22:43:37 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:37 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:37 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:37 +0100] [Job 37] (monitor) Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:37 +0100] [Job 37] (monitor) job-state=processing
I [03/Dec/2013:22:43:37 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:37 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:37 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:37 +0100] [Job 37] Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:37 +0100] [Job 37] update_reasons(attr=0(), s="+cups-remote-processing")
D [03/Dec/2013:22:43:37 +0100] [Job 37] PAGE: total 1
I [03/Dec/2013:22:43:39 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:39 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:39 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:39 +0100] [Job 37] (monitor) Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:39 +0100] [Job 37] (monitor) job-state=processing
I [03/Dec/2013:22:43:39 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:39 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:39 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:39 +0100] [Job 37] Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:39 +0100] [Job 37] update_reasons(attr=0(), s="+cups-remote-processing")
D [03/Dec/2013:22:43:39 +0100] [Job 37] PAGE: total 1
I [03/Dec/2013:22:43:42 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:42 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:42 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:42 +0100] [Job 37] (monitor) Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:42 +0100] [Job 37] (monitor) job-state=processing
I [03/Dec/2013:22:43:42 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:42 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:42 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:42 +0100] [Job 37] Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:42 +0100] [Job 37] update_reasons(attr=0(), s="+cups-remote-processing")
D [03/Dec/2013:22:43:42 +0100] [Job 37] PAGE: total 1
I [03/Dec/2013:22:43:48 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:48 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:48 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:48 +0100] [Job 37] Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:48 +0100] [Job 37] update_reasons(attr=0(), s="+cups-remote-processing")
D [03/Dec/2013:22:43:48 +0100] [Job 37] PAGE: total 1
I [03/Dec/2013:22:43:48 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:48 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:48 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:48 +0100] [Job 37] (monitor) Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:48 +0100] [Job 37] (monitor) job-state=processing
I [03/Dec/2013:22:43:56 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:56 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:56 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:56 +0100] [Job 37] Get-Job-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:56 +0100] [Job 37] update_reasons(attr=0(), s="+cups-remote-completed")
D [03/Dec/2013:22:43:56 +0100] [Job 37] STATE: +cups-remote-completed
D [03/Dec/2013:22:43:56 +0100] [Job 37] STATE: -cups-remote-processing
D [03/Dec/2013:22:43:56 +0100] [Job 37] PAGE: total 1
I [03/Dec/2013:22:43:56 +0100] [Job 37] Sending data to printer.
D [03/Dec/2013:22:43:56 +0100] [Job 37] update_reasons(attr=1(none), s="(null)")
D [03/Dec/2013:22:43:56 +0100] [Job 37] Get-Printer-Attributes: successful-ok (successful-ok)
D [03/Dec/2013:22:43:56 +0100] [Job 37] ATTR: auth-info-required=none
D [03/Dec/2013:22:43:56 +0100] [Job 37] PID 31733 (/usr/lib/cups/backend/ipp) exited with no errors.
D [03/Dec/2013:22:43:56 +0100] [Job 37] time-at-completed=1386107036
I [03/Dec/2013:22:43:56 +0100] [Job 37] Job completed.
D [03/Dec/2013:22:43:57 +0100] [Job 37] Unloading...
')
Server side error_log
$this->bbcode_second_pass_code('', '
I [03/Dec/2013:22:43:21 +0100] [Job 70] Adding start banner page "none".
I [03/Dec/2013:22:43:21 +0100] [Job 70] Queued on "bj" by "nolby".
D [03/Dec/2013:22:43:21 +0100] [Job 70] Auto-typing file...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Request file type is application/vnd.cups-raw.
I [03/Dec/2013:22:43:21 +0100] [Job 70] File of type application/vnd.cups-raw queued by "nolby".
I [03/Dec/2013:22:43:21 +0100] [Job 70] Adding end banner page "none".
D [03/Dec/2013:22:43:21 +0100] [Job 70] time-at-processing=1386107001
D [03/Dec/2013:22:43:21 +0100] [Job 70] Sending job to queue tagged as raw...
D [03/Dec/2013:22:43:21 +0100] [Job 70] job-sheets=none,none
D [03/Dec/2013:22:43:21 +0100] [Job 70] argv[0]="bj"
D [03/Dec/2013:22:43:21 +0100] [Job 70] argv[1]="70"
D [03/Dec/2013:22:43:21 +0100] [Job 70] argv[2]="nolby"
D [03/Dec/2013:22:43:21 +0100] [Job 70] argv[3]="11-bakup-hard-disc.rules"
D [03/Dec/2013:22:43:21 +0100] [Job 70] argv[4]="1"
D [03/Dec/2013:22:43:21 +0100] [Job 70] argv[5]="job-uuid=urn:uuid:e37c0772-8114-3f6e-7937-1bc63fedbf4c job-originating-host-name=192.168.11.55 time-at-creation=1386107001 time-at-processing=1386107001"
D [03/Dec/2013:22:43:21 +0100] [Job 70] argv[6]="/var/spool/cups/d00070-001"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[7]="CUPS_STATEDIR=/run/cups"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[8]="HOME=/var/spool/cups/tmp"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[10]="SERVER_ADMIN=root@jack"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[11]="SOFTWARE=CUPS/1.7.0"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[13]="USER=root"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[14]="CUPS_MAX_MESSAGE=2047"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[17]="IPP_PORT=631"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[18]="CHARSET=utf-8"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[19]="LANG=en_US.UTF-8"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[20]="PPD=/etc/cups/ppd/bj.ppd"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[21]="RIP_MAX_CACHE=128m"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[22]="CONTENT_TYPE=application/vnd.cups-raw"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[23]="DEVICE_URI=usb://Brother/HL-2030%20series?serial=D7J580621"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[24]="PRINTER_INFO=bj"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[25]="PRINTER_LOCATION="
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[26]="PRINTER=bj"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[27]="PRINTER_STATE_REASONS=none"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[28]="CUPS_FILETYPE=document"
D [03/Dec/2013:22:43:21 +0100] [Job 70] envp[29]="AUTH_I****"
I [03/Dec/2013:22:43:21 +0100] [Job 70] Started backend /usr/lib/cups/backend/usb (PID 10112)
D [03/Dec/2013:22:43:21 +0100] [Job 70] Loading USB quirks from "/usr/share/cups/usb".
D [03/Dec/2013:22:43:21 +0100] [Job 70] Loaded 67 quirks.
D [03/Dec/2013:22:43:21 +0100] [Job 70] Printing on printer with URI: usb://Brother/HL-2030%20series?serial=D7J580621
D [03/Dec/2013:22:43:21 +0100] [Job 70] libusb_get_device_list=4
D [03/Dec/2013:22:43:21 +0100] [Job 70] STATE: +connecting-to-device
D [03/Dec/2013:22:43:21 +0100] [Job 70] STATE: -connecting-to-device
D [03/Dec/2013:22:43:21 +0100] [Job 70] Device protocol: 2
I [03/Dec/2013:22:43:21 +0100] [Job 70] Sending data to printer.
D [03/Dec/2013:22:43:21 +0100] [Job 70] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [03/Dec/2013:22:43:21 +0100] [Job 70] PAGE: 1 1
D [03/Dec/2013:22:43:21 +0100] [Job 70] Read 8192 bytes of print data...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Wrote 8192 bytes of print data...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Sending print file, 8192 bytes...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Read 8192 bytes of print data...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Wrote 8192 bytes of print data...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Sending print file, 16384 bytes...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Read 8192 bytes of print data...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Wrote 8192 bytes of print data...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Sending print file, 24576 bytes...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Read 8192 bytes of print data...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Wrote 8192 bytes of print data...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Sending print file, 32768 bytes...
D [03/Dec/2013:22:43:21 +0100] [Job 70] Read 1678 bytes of print data...
D [03/Dec/2013:22:43:37 +0100] [Job 70] Wrote 1678 bytes of print data...
D [03/Dec/2013:22:43:37 +0100] [Job 70] Sending print file, 34446 bytes...
D [03/Dec/2013:22:43:37 +0100] [Job 70] Sent 34446 bytes...
D [03/Dec/2013:22:43:37 +0100] [Job 70] Waiting for read thread to exit...
D [03/Dec/2013:22:43:37 +0100] [Job 70] PID 10112 (/usr/lib/cups/backend/usb) exited with no errors.
D [03/Dec/2013:22:43:37 +0100] [Job 70] time-at-completed=1386107017
I [03/Dec/2013:22:43:37 +0100] [Job 70] Job completed.
D [03/Dec/2013:22:43:38 +0100] [Job 70] Unloading...
D [03/Dec/2013:22:43:41 +0100] [Job 70] Loading attributes...
D [03/Dec/2013:22:44:51 +0100] [Job 70] Unloading...
')

by **Geoff** » Tue Dec 03, 2013 11:58 pm

I can't tell from your logfiles, but it sounds like the client (laptop) might be using the wrong driver for your printer. You might try connecting the printer directly to the laptop at first, to determine which driver works best.

by **icy6210** » Wed Dec 04, 2013 11:08 pm

@Geoff
The hl1250 driver is native on ghostcript and recommended ppd of foomatic. It worked flawlessly for years even on my Icybox + archlinuxarm, server and client side. After systemd stopped working *only* with archlinuxarm. Anyway in the beginning of the 3d i posted that have already made the test you suggest. Thanks anyway for your answer.

foomatic, ghostscript, cups misworking

foomatic, ghostscript, cups misworking

Re: foomatic, ghostscript, cups misworking

Re: foomatic, ghostscript, cups misworking

Re: foomatic, ghostscript, cups misworking

Re: foomatic, ghostscript, cups misworking

Re: foomatic, ghostscript, cups misworking

Re: foomatic, ghostscript, cups misworking

Who is online