Attachment 833114 Details for Bug 1036428 – error log

error log

error_log.txt (text/plain), 43.07 KB, created by veidea on 2013-12-05 12:13:27 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: veidea

Created: 2013-12-05 12:13:27 UTC

Size: 43.07 KB

patch

obsolete

>E [01/Dec/2013:20:25:47 -0300] Unknown directive BrowseOrder on line 6 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:25:47 -0300] Unknown directive BrowseAllow on line 7 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:25:47 -0300] Unknown browse protocol "CUPS" ignored.
>E [01/Dec/2013:20:25:47 -0300] Unknown directive JobPrivateAccess on line 85 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:25:47 -0300] Unknown directive JobPrivateValues on line 86 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:25:47 -0300] Unknown directive SubscriptionPrivateAccess on line 87 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:25:47 -0300] Unknown directive SubscriptionPrivateValues on line 88 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:34:55 -0300] [Job 112] Job stopped due to filter errors; please consult the error_log file for details.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] The following messages were recorded from 08:28:12 PM to 08:34:55 PM
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Adding start banner page "none".
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Queued on "Canon-BJC-4200" by "v.espinoza".
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Auto-typing file...
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Request file type is text/plain.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] File of type text/plain queued by "v.espinoza".
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Adding end banner page "none".
>D [01/Dec/2013:20:34:55 -0300] [Job 112] time-at-processing=1385940492
>D [01/Dec/2013:20:34:55 -0300] [Job 112] 4 filters for job:
>D [01/Dec/2013:20:34:55 -0300] [Job 112] texttopaps (text/plain to application/postscript, cost 30)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] pstopdf (application/postscript to application/pdf, cost 0)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] foomatic-rip (application/vnd.cups-pdf to printer/Canon-BJC-4200, cost 0)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] job-sheets=none,none
>D [01/Dec/2013:20:34:55 -0300] [Job 112] argv[0]="Canon-BJC-4200"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] argv[1]="112"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] argv[2]="v.espinoza"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] argv[3]="unison.log"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] argv[4]="1"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:5a69f9f0-9f55-385a-7cac-f94bb99b4fec job-originating-host-name=localhost time-at-creation=1385940492 time-at-processing=1385940492"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] argv[6]="/var/spool/cups/d00112-001"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[1]="CUPS_DATADIR=/usr/share/cups"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[6]="CUPS_SERVERROOT=/etc/cups"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[7]="CUPS_STATEDIR=/var/run/cups"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[8]="HOME=/var/spool/cups/tmp"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[10]="SERVER_ADMIN=root@lenovo.ve"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[11]="SOFTWARE=CUPS/1.6.4"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[12]="TMPDIR=/var/spool/cups/tmp"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[13]="USER=root"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[14]="CUPS_MAX_MESSAGE=2047"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[16]="CUPS_ENCRYPTION=IfRequested"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[17]="IPP_PORT=631"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[18]="CHARSET=utf-8"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[19]="LANG=en_US.UTF-8"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[20]="PPD=/etc/cups/ppd/Canon-BJC-4200.ppd"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[21]="RIP_MAX_CACHE=128m"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[22]="CONTENT_TYPE=text/plain"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[23]="DEVICE_URI=usb://Canon/BJC-4200"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[24]="PRINTER_INFO=Canon BJC-4200"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[25]="PRINTER_LOCATION=lenovo.ve"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[26]="PRINTER=Canon-BJC-4200"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[27]="PRINTER_STATE_REASONS=none"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[28]="CUPS_FILETYPE=document"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[29]="FINAL_CONTENT_TYPE=printer/Canon-BJC-4200"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] envp[30]="AUTH_I****"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Started filter /usr/lib/cups/filter/texttopaps (PID 20110)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Started filter /usr/lib/cups/filter/pstopdf (PID 20111)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Started filter /usr/lib/cups/filter/pdftopdf (PID 20112)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Started filter /usr/lib/cups/filter/foomatic-rip (PID 20113)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Started backend /usr/lib/cups/backend/usb (PID 20114)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Getting input from file 
>D [01/Dec/2013:20:34:55 -0300] [Job 112] foomatic-rip version 4.0.17.256 running...
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Parsing PPD file ...
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option ColorSpace
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option PageSize
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option ImageableArea
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option PaperDimension
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option Manual
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option MediaType
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option MediaWeight
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option PrintQuality
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option BitsPerPixel
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option Monochrome
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option ProcessColorModel
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option Resolution
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option PrintColors
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Added option Font
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Parameter Summary
>D [01/Dec/2013:20:34:55 -0300] [Job 112] -----------------
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Spooler: cups
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Printer: Canon-BJC-4200
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Shell: /bin/bash
>D [01/Dec/2013:20:34:55 -0300] [Job 112] PPD file: /etc/cups/ppd/Canon-BJC-4200.ppd
>D [01/Dec/2013:20:34:55 -0300] [Job 112] ATTR file: 
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Printer model: Canon BJC-4200 Foomatic/bjc600 (recommended)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Job title: unison.log
>D [01/Dec/2013:20:34:55 -0300] [Job 112] File(s) to be printed:
>D [01/Dec/2013:20:34:55 -0300] [Job 112] <STDIN>
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Printing system options:
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Pondering option 'finishings=3'
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Unknown option finishings=3.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Pondering option 'number-up=1'
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Unknown option number-up=1.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Pondering option 'job-uuid=urn:uuid:5a69f9f0-9f55-385a-7cac-f94bb99b4fec'
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Unknown option job-uuid=urn:uuid:5a69f9f0-9f55-385a-7cac-f94bb99b4fec.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Pondering option 'job-originating-host-name=localhost'
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Unknown option job-originating-host-name=localhost.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Pondering option 'time-at-creation=1385940492'
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Unknown option time-at-creation=1385940492.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Pondering option 'time-at-processing=1385940492'
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Unknown option time-at-processing=1385940492.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Options from the PPD file:
>D [01/Dec/2013:20:34:55 -0300] [Job 112] ================================================
>D [01/Dec/2013:20:34:55 -0300] [Job 112] File: <STDIN>
>D [01/Dec/2013:20:34:55 -0300] [Job 112] ================================================
>D [01/Dec/2013:20:34:55 -0300] [Job 112] pstopdf 5 args: 112 v.espinoza unison.log 1 finishings=3 number-up=1 job-uuid=urn:uuid:5a69f9f0-9f55-385a-7cac-f94bb99b4fec job-originating-host-name=localhost time-at-creation=1385940492 time-at-processing=1385940492
>D [01/Dec/2013:20:34:55 -0300] [Job 112] PPD: /etc/cups/ppd/Canon-BJC-4200.ppd
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Loading USB quirks from "/usr/share/cups/usb".
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Loaded 68 quirks.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Printing on printer with URI: usb://Canon/BJC-4200
>D [01/Dec/2013:20:34:55 -0300] [Job 112] libusb_get_device_list=10
>D [01/Dec/2013:20:34:55 -0300] [Job 112] STATE: +connecting-to-device
>D [01/Dec/2013:20:34:55 -0300] [Job 112] STATE: -connecting-to-device
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Printer found with device ID: MFG:Canon;CMD:BJ,LQ,BJL,BJRaster,BSCC;MDL:BJC-4200;CLS:PRINTER;DES:Canon BJC-4200; Device URI: usb://Canon/BJC-4200
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Device protocol: 2
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Printer does not like usblp kernel module to be re-attached after job
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Sending data to printer.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Set job-printer-state-message to "Sending data to printer.", current level=INFO
>D [01/Dec/2013:20:34:55 -0300] [Job 112] PID 20110 (/usr/lib/cups/filter/texttopaps) exited with no errors.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Resolution: 360x360
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Page size: Letter
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Width: 612, height: 792, absolute margins: 18, 36, 594, 756
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Relative margins: 18, 36, 18, 36
>D [01/Dec/2013:20:34:55 -0300] [Job 112] PPD options: -r360 -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792
>D [01/Dec/2013:20:34:55 -0300] [Job 112] PostScript to be injected: 
>D [01/Dec/2013:20:34:55 -0300] [Job 112] 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 -r360 -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -sOutputFile=-  -c .setpdfwrite -f -
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Got USB transaction timeout during read.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Got USB transaction timeout during read.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Got USB transaction timeout during read.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Got USB transaction timeout during read.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Got USB transaction timeout during read.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Got USB transaction timeout during read.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] PID 20111 (/usr/lib/cups/filter/pstopdf) exited with no errors.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Filetype: PDF
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Storing temporary files in /var/spool/cups/tmp
>D [01/Dec/2013:20:34:55 -0300] [Job 112] PID 20112 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] File contains 431 pages
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Starting renderer with command: gs -dFirstPage=1  -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -dNOINTERPOLATE -sDEVICE=bjc600 -dPrintColors=15 -dProcessColorModel=/DeviceCMYK -dBitsPerPixel=24 -sPrintQuality=Normal -dMediaWeight=80 -sMediaType=PlainPaper -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -r360x360 -sOutputFile=-   /var/spool/cups/tmp/foomatic-JJnW1t 
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Starting process "kid3" (generation 1)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Starting process "kid4" (generation 2)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Starting process "renderer" (generation 2)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] JCL: %-12345X@PJL
>D [01/Dec/2013:20:34:55 -0300] [Job 112] <job data> 
>D [01/Dec/2013:20:34:55 -0300] [Job 112] renderer received signal 11
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Kid3 exit status: 1
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Sent 0 bytes...
>D [01/Dec/2013:20:34:55 -0300] [Job 112] PID 20113 (/usr/lib/cups/filter/foomatic-rip) stopped with status 9.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Hint: Try setting the LogLevel to "debug" to find out more.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Waiting for read thread to exit...
>D [01/Dec/2013:20:34:55 -0300] [Job 112] Read thread still active, aborting the pending read...
>D [01/Dec/2013:20:34:55 -0300] [Job 112] PID 20114 (/usr/lib/cups/backend/usb) exited with no errors.
>D [01/Dec/2013:20:34:55 -0300] [Job 112] End of messages
>D [01/Dec/2013:20:34:55 -0300] [Job 112] printer-state=3(idle)
>D [01/Dec/2013:20:34:55 -0300] [Job 112] printer-state-message="Filter failed"
>D [01/Dec/2013:20:34:55 -0300] [Job 112] printer-state-reasons=none
>E [01/Dec/2013:20:39:56 -0300] [Job 112] Stopping unresponsive job.
>E [01/Dec/2013:20:53:58 -0300] Unknown directive BrowseOrder on line 9 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:53:58 -0300] Unknown directive BrowseAllow on line 10 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:53:58 -0300] Unknown directive JobPrivateAccess on line 89 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:53:58 -0300] Unknown directive JobPrivateValues on line 90 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:53:58 -0300] Unknown directive SubscriptionPrivateAccess on line 91 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:53:58 -0300] Unknown directive SubscriptionPrivateValues on line 92 of /etc/cups/cupsd.conf.
>W [01/Dec/2013:20:53:59 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-Gray..' already exists
>W [01/Dec/2013:20:53:59 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-RGB..' already exists
>W [01/Dec/2013:20:53:59 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'ML-1610-Gray..' already exists
>I [01/Dec/2013:20:54:56 -0300] Listening to 0.0.0.0:631 (IPv4)
>I [01/Dec/2013:20:54:56 -0300] Listening to [v1.::]:631 (IPv6)
>I [01/Dec/2013:20:54:56 -0300] Listening to /var/run/cups/cups.sock (Domain)
>E [01/Dec/2013:20:54:56 -0300] Unknown directive BrowseOrder on line 8 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:54:56 -0300] Unknown directive BrowseAllow on line 9 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:54:56 -0300] Unknown directive JobPrivateAccess on line 87 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:54:56 -0300] Unknown directive JobPrivateValues on line 88 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:54:56 -0300] Unknown directive SubscriptionPrivateAccess on line 89 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:54:56 -0300] Unknown directive SubscriptionPrivateValues on line 90 of /etc/cups/cupsd.conf.
>W [01/Dec/2013:20:54:56 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-Gray..' already exists
>W [01/Dec/2013:20:54:56 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-RGB..' already exists
>W [01/Dec/2013:20:54:56 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'ML-1610-Gray..' already exists
>E [01/Dec/2013:20:55:01 -0300] Unknown directive BrowseOrder on line 8 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:55:01 -0300] Unknown directive BrowseAllow on line 9 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:55:01 -0300] Unknown directive JobPrivateAccess on line 87 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:55:01 -0300] Unknown directive JobPrivateValues on line 88 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:55:01 -0300] Unknown directive SubscriptionPrivateAccess on line 89 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:55:01 -0300] Unknown directive SubscriptionPrivateValues on line 90 of /etc/cups/cupsd.conf.
>W [01/Dec/2013:20:55:01 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-Gray..' already exists
>W [01/Dec/2013:20:55:01 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-RGB..' already exists
>W [01/Dec/2013:20:55:01 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'ML-1610-Gray..' already exists
>E [01/Dec/2013:20:58:22 -0300] Unknown directive BrowseOrder on line 7 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:58:22 -0300] Unknown directive BrowseAllow on line 8 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:58:22 -0300] Unknown directive JobPrivateAccess on line 86 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:58:22 -0300] Unknown directive JobPrivateValues on line 87 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:58:22 -0300] Unknown directive SubscriptionPrivateAccess on line 88 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:58:22 -0300] Unknown directive SubscriptionPrivateValues on line 89 of /etc/cups/cupsd.conf.
>W [01/Dec/2013:20:58:22 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-Gray..' already exists
>W [01/Dec/2013:20:58:22 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-RGB..' already exists
>W [01/Dec/2013:20:58:22 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'ML-1610-Gray..' already exists
>I [01/Dec/2013:20:58:46 -0300] Listening to 0.0.0.0:631 (IPv4)
>I [01/Dec/2013:20:58:46 -0300] Listening to [v1.::]:631 (IPv6)
>I [01/Dec/2013:20:58:46 -0300] Listening to /var/run/cups/cups.sock (Domain)
>E [01/Dec/2013:20:58:46 -0300] Unknown directive BrowseOrder on line 8 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:58:46 -0300] Unknown directive BrowseAllow on line 9 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:58:46 -0300] Unknown directive JobPrivateAccess on line 87 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:58:46 -0300] Unknown directive JobPrivateValues on line 88 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:58:46 -0300] Unknown directive SubscriptionPrivateAccess on line 89 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:58:46 -0300] Unknown directive SubscriptionPrivateValues on line 90 of /etc/cups/cupsd.conf.
>W [01/Dec/2013:20:58:46 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-Gray..' already exists
>W [01/Dec/2013:20:58:46 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-RGB..' already exists
>W [01/Dec/2013:20:58:46 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'ML-1610-Gray..' already exists
>E [01/Dec/2013:20:59:03 -0300] Unknown directive BrowseOrder on line 8 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:59:03 -0300] Unknown directive BrowseAllow on line 9 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:59:03 -0300] Unknown directive JobPrivateAccess on line 87 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:59:03 -0300] Unknown directive JobPrivateValues on line 88 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:59:03 -0300] Unknown directive SubscriptionPrivateAccess on line 89 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:59:03 -0300] Unknown directive SubscriptionPrivateValues on line 90 of /etc/cups/cupsd.conf.
>W [01/Dec/2013:20:59:03 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-Gray..' already exists
>W [01/Dec/2013:20:59:03 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-RGB..' already exists
>W [01/Dec/2013:20:59:03 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'ML-1610-Gray..' already exists
>E [01/Dec/2013:20:59:20 -0300] Unknown directive BrowseOrder on line 7 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:59:20 -0300] Unknown directive BrowseAllow on line 8 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:59:20 -0300] Unknown directive JobPrivateAccess on line 86 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:59:20 -0300] Unknown directive JobPrivateValues on line 87 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:59:20 -0300] Unknown directive SubscriptionPrivateAccess on line 88 of /etc/cups/cupsd.conf.
>E [01/Dec/2013:20:59:20 -0300] Unknown directive SubscriptionPrivateValues on line 89 of /etc/cups/cupsd.conf.
>W [01/Dec/2013:20:59:20 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-Gray..' already exists
>W [01/Dec/2013:20:59:20 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'Canon-BJC-4200-RGB..' already exists
>W [01/Dec/2013:20:59:20 -0300] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id 'ML-1610-Gray..' already exists
>E [03/Dec/2013:08:46:01 -0300] Unknown directive BrowseOrder on line 7 of /etc/cups/cupsd.conf.
>E [03/Dec/2013:08:46:01 -0300] Unknown directive BrowseAllow on line 8 of /etc/cups/cupsd.conf.
>E [03/Dec/2013:08:46:01 -0300] Unknown directive JobPrivateAccess on line 86 of /etc/cups/cupsd.conf.
>E [03/Dec/2013:08:46:01 -0300] Unknown directive JobPrivateValues on line 87 of /etc/cups/cupsd.conf.
>E [03/Dec/2013:08:46:01 -0300] Unknown directive SubscriptionPrivateAccess on line 88 of /etc/cups/cupsd.conf.
>E [03/Dec/2013:08:46:01 -0300] Unknown directive SubscriptionPrivateValues on line 89 of /etc/cups/cupsd.conf.
>E [03/Dec/2013:08:50:52 -0300] [Job 113] Job stopped due to filter errors; please consult the error_log file for details.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] The following messages were recorded from 08:50:43 AM to 08:50:52 AM
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Adding start banner page "none".
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Adding end banner page "none".
>D [03/Dec/2013:08:50:52 -0300] [Job 113] File of type application/vnd.cups-pdf-banner queued by "v.espinoza".
>D [03/Dec/2013:08:50:52 -0300] [Job 113] hold_until=0
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Queued on "Canon-BJC-4200" by "v.espinoza".
>D [03/Dec/2013:08:50:52 -0300] [Job 113] time-at-processing=1386071443
>D [03/Dec/2013:08:50:52 -0300] [Job 113] 3 filters for job:
>D [03/Dec/2013:08:50:52 -0300] [Job 113] bannertopdf (application/vnd.cups-pdf-banner to application/pdf, cost 32)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] foomatic-rip (application/vnd.cups-pdf to printer/Canon-BJC-4200, cost 0)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] job-sheets=none,none
>D [03/Dec/2013:08:50:52 -0300] [Job 113] argv[0]="Canon-BJC-4200"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] argv[1]="113"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] argv[2]="v.espinoza"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] argv[3]="Test Page"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] argv[4]="1"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] argv[5]="job-uuid=urn:uuid:3067c099-e727-3e4b-5cd6-31e68ca76e34 job-originating-host-name=localhost time-at-creation=1386071443 time-at-processing=1386071443"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] argv[6]="/var/spool/cups/d00113-001"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[1]="CUPS_DATADIR=/usr/share/cups"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[6]="CUPS_SERVERROOT=/etc/cups"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[7]="CUPS_STATEDIR=/var/run/cups"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[8]="HOME=/var/spool/cups/tmp"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[10]="SERVER_ADMIN=root@lenovo.ve"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[11]="SOFTWARE=CUPS/1.6.4"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[12]="TMPDIR=/var/spool/cups/tmp"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[13]="USER=root"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[14]="CUPS_MAX_MESSAGE=2047"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[16]="CUPS_ENCRYPTION=IfRequested"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[17]="IPP_PORT=631"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[18]="CHARSET=utf-8"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[19]="LANG=en_US.UTF-8"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[20]="PPD=/etc/cups/ppd/Canon-BJC-4200.ppd"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[21]="RIP_MAX_CACHE=128m"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[23]="DEVICE_URI=usb://Canon/BJC-4200"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[24]="PRINTER_INFO=Canon BJC-4200"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[25]="PRINTER_LOCATION=lenovo.ve"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[26]="PRINTER=Canon-BJC-4200"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[27]="PRINTER_STATE_REASONS=none"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[28]="CUPS_FILETYPE=document"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[29]="FINAL_CONTENT_TYPE=printer/Canon-BJC-4200"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] envp[30]="AUTH_I****"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Started filter /usr/lib/cups/filter/bannertopdf (PID 3225)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Started filter /usr/lib/cups/filter/pdftopdf (PID 3226)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Started filter /usr/lib/cups/filter/foomatic-rip (PID 3227)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Started backend /usr/lib/cups/backend/usb (PID 3228)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Getting input from file 
>D [03/Dec/2013:08:50:52 -0300] [Job 113] foomatic-rip version 4.0.17.256 running...
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Parsing PPD file ...
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option ColorSpace
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option PageSize
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Loading USB quirks from "/usr/share/cups/usb".
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Loaded 68 quirks.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option ImageableArea
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Printing on printer with URI: usb://Canon/BJC-4200
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option PaperDimension
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option Manual
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option MediaType
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option MediaWeight
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option PrintQuality
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option BitsPerPixel
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option Monochrome
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option ProcessColorModel
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option Resolution
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option PrintColors
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Added option Font
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Parameter Summary
>D [03/Dec/2013:08:50:52 -0300] [Job 113] -----------------
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Spooler: cups
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Printer: Canon-BJC-4200
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Shell: /bin/bash
>D [03/Dec/2013:08:50:52 -0300] [Job 113] PPD file: /etc/cups/ppd/Canon-BJC-4200.ppd
>D [03/Dec/2013:08:50:52 -0300] [Job 113] ATTR file: 
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Printer model: Canon BJC-4200 Foomatic/bjc600 (recommended)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Job title: Test Page
>D [03/Dec/2013:08:50:52 -0300] [Job 113] File(s) to be printed:
>D [03/Dec/2013:08:50:52 -0300] [Job 113] <STDIN>
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Printing system options:
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Pondering option 'job-uuid=urn:uuid:3067c099-e727-3e4b-5cd6-31e68ca76e34'
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Unknown option job-uuid=urn:uuid:3067c099-e727-3e4b-5cd6-31e68ca76e34.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Pondering option 'job-originating-host-name=localhost'
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Unknown option job-originating-host-name=localhost.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Pondering option 'time-at-creation=1386071443'
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Unknown option time-at-creation=1386071443.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Pondering option 'time-at-processing=1386071443'
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Unknown option time-at-processing=1386071443.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Options from the PPD file:
>D [03/Dec/2013:08:50:52 -0300] [Job 113] ================================================
>D [03/Dec/2013:08:50:52 -0300] [Job 113] File: <STDIN>
>D [03/Dec/2013:08:50:52 -0300] [Job 113] ================================================
>D [03/Dec/2013:08:50:52 -0300] [Job 113] libusb_get_device_list=10
>D [03/Dec/2013:08:50:52 -0300] [Job 113] STATE: +connecting-to-device
>D [03/Dec/2013:08:50:52 -0300] [Job 113] STATE: -connecting-to-device
>D [03/Dec/2013:08:50:52 -0300] [Job 113] PID 3225 (/usr/lib/cups/filter/bannertopdf) exited with no errors.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Filetype: PDF
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Storing temporary files in /var/spool/cups/tmp
>D [03/Dec/2013:08:50:52 -0300] [Job 113] PID 3226 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Printer found with device ID: MFG:Canon;CMD:BJ,LQ,BJL,BJRaster,BSCC;MDL:BJC-4200;CLS:PRINTER;DES:Canon BJC-4200; Device URI: usb://Canon/BJC-4200
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Device protocol: 2
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Printer does not like usblp kernel module to be re-attached after job
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Sending data to printer.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Set job-printer-state-message to "Sending data to printer.", current level=INFO
>D [03/Dec/2013:08:50:52 -0300] [Job 113] File contains 1 pages
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Starting renderer with command: gs -dFirstPage=1  -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -dNOINTERPOLATE -sDEVICE=bjc600 -dPrintColors=15 -dProcessColorModel=/DeviceCMYK -dBitsPerPixel=24 -sPrintQuality=Normal -dMediaWeight=80 -sMediaType=PlainPaper -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -r360x360 -sOutputFile=-   /var/spool/cups/tmp/foomatic-KNWZdv 
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Starting process "kid3" (generation 1)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Starting process "kid4" (generation 2)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Starting process "renderer" (generation 2)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] JCL: %-12345X@PJL
>D [03/Dec/2013:08:50:52 -0300] [Job 113] <job data> 
>D [03/Dec/2013:08:50:52 -0300] [Job 113] renderer received signal 11
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Kid3 exit status: 1
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Sent 0 bytes...
>D [03/Dec/2013:08:50:52 -0300] [Job 113] PID 3227 (/usr/lib/cups/filter/foomatic-rip) stopped with status 9.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Hint: Try setting the LogLevel to "debug" to find out more.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Waiting for read thread to exit...
>D [03/Dec/2013:08:50:52 -0300] [Job 113] Read thread still active, aborting the pending read...
>D [03/Dec/2013:08:50:52 -0300] [Job 113] PID 3228 (/usr/lib/cups/backend/usb) exited with no errors.
>D [03/Dec/2013:08:50:52 -0300] [Job 113] End of messages
>D [03/Dec/2013:08:50:52 -0300] [Job 113] printer-state=3(idle)
>D [03/Dec/2013:08:50:52 -0300] [Job 113] printer-state-message="Filter failed"
>D [03/Dec/2013:08:50:52 -0300] [Job 113] printer-state-reasons=none
>E [03/Dec/2013:08:51:10 -0300] [Job 114] Job stopped due to filter errors; please consult the error_log file for details.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] The following messages were recorded from 08:51:02 AM to 08:51:10 AM
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Adding start banner page "none".
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Adding end banner page "none".
>D [03/Dec/2013:08:51:10 -0300] [Job 114] File of type application/vnd.cups-pdf-banner queued by "v.espinoza".
>D [03/Dec/2013:08:51:10 -0300] [Job 114] hold_until=0
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Queued on "Canon-BJC-4200" by "v.espinoza".
>D [03/Dec/2013:08:51:10 -0300] [Job 114] time-at-processing=1386071462
>D [03/Dec/2013:08:51:10 -0300] [Job 114] 3 filters for job:
>D [03/Dec/2013:08:51:10 -0300] [Job 114] bannertopdf (application/vnd.cups-pdf-banner to application/pdf, cost 32)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] foomatic-rip (application/vnd.cups-pdf to printer/Canon-BJC-4200, cost 0)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] job-sheets=none,none
>D [03/Dec/2013:08:51:10 -0300] [Job 114] argv[0]="Canon-BJC-4200"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] argv[1]="114"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] argv[2]="v.espinoza"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] argv[3]="Test Page"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] argv[4]="1"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] argv[5]="job-uuid=urn:uuid:f324324d-5c53-38cc-718b-14acb7e73732 job-originating-host-name=localhost time-at-creation=1386071462 time-at-processing=1386071462"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] argv[6]="/var/spool/cups/d00114-001"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[1]="CUPS_DATADIR=/usr/share/cups"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[6]="CUPS_SERVERROOT=/etc/cups"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[7]="CUPS_STATEDIR=/var/run/cups"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[8]="HOME=/var/spool/cups/tmp"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[10]="SERVER_ADMIN=root@lenovo.ve"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[11]="SOFTWARE=CUPS/1.6.4"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[12]="TMPDIR=/var/spool/cups/tmp"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[13]="USER=root"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[14]="CUPS_MAX_MESSAGE=2047"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[16]="CUPS_ENCRYPTION=IfRequested"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[17]="IPP_PORT=631"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[18]="CHARSET=utf-8"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[19]="LANG=en_US.UTF-8"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[20]="PPD=/etc/cups/ppd/Canon-BJC-4200.ppd"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[21]="RIP_MAX_CACHE=128m"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[23]="DEVICE_URI=usb://Canon/BJC-4200"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[24]="PRINTER_INFO=Canon BJC-4200"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[25]="PRINTER_LOCATION=lenovo.ve"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[26]="PRINTER=Canon-BJC-4200"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[27]="PRINTER_STATE_REASONS=none"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[28]="CUPS_FILETYPE=document"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[29]="FINAL_CONTENT_TYPE=printer/Canon-BJC-4200"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] envp[30]="AUTH_I****"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Started filter /usr/lib/cups/filter/bannertopdf (PID 3244)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Started filter /usr/lib/cups/filter/pdftopdf (PID 3245)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Started filter /usr/lib/cups/filter/foomatic-rip (PID 3246)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Started backend /usr/lib/cups/backend/usb (PID 3247)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Getting input from file 
>D [03/Dec/2013:08:51:10 -0300] [Job 114] foomatic-rip version 4.0.17.256 running...
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Parsing PPD file ...
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option ColorSpace
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option PageSize
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option ImageableArea
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option PaperDimension
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option Manual
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option MediaType
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option MediaWeight
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option PrintQuality
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option BitsPerPixel
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option Monochrome
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option ProcessColorModel
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option Resolution
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option PrintColors
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Added option Font
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Parameter Summary
>D [03/Dec/2013:08:51:10 -0300] [Job 114] -----------------
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Spooler: cups
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Printer: Canon-BJC-4200
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Shell: /bin/bash
>D [03/Dec/2013:08:51:10 -0300] [Job 114] PPD file: /etc/cups/ppd/Canon-BJC-4200.ppd
>D [03/Dec/2013:08:51:10 -0300] [Job 114] ATTR file: 
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Printer model: Canon BJC-4200 Foomatic/bjc600 (recommended)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Job title: Test Page
>D [03/Dec/2013:08:51:10 -0300] [Job 114] File(s) to be printed:
>D [03/Dec/2013:08:51:10 -0300] [Job 114] <STDIN>
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Printing system options:
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Pondering option 'job-uuid=urn:uuid:f324324d-5c53-38cc-718b-14acb7e73732'
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Unknown option job-uuid=urn:uuid:f324324d-5c53-38cc-718b-14acb7e73732.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Pondering option 'job-originating-host-name=localhost'
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Unknown option job-originating-host-name=localhost.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Pondering option 'time-at-creation=1386071462'
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Unknown option time-at-creation=1386071462.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Pondering option 'time-at-processing=1386071462'
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Unknown option time-at-processing=1386071462.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Options from the PPD file:
>D [03/Dec/2013:08:51:10 -0300] [Job 114] ================================================
>D [03/Dec/2013:08:51:10 -0300] [Job 114] File: <STDIN>
>D [03/Dec/2013:08:51:10 -0300] [Job 114] ================================================
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Loading USB quirks from "/usr/share/cups/usb".
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Loaded 68 quirks.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Printing on printer with URI: usb://Canon/BJC-4200
>D [03/Dec/2013:08:51:10 -0300] [Job 114] libusb_get_device_list=10
>D [03/Dec/2013:08:51:10 -0300] [Job 114] STATE: +connecting-to-device
>D [03/Dec/2013:08:51:10 -0300] [Job 114] STATE: -connecting-to-device
>D [03/Dec/2013:08:51:10 -0300] [Job 114] PID 3244 (/usr/lib/cups/filter/bannertopdf) exited with no errors.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Filetype: PDF
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Storing temporary files in /var/spool/cups/tmp
>D [03/Dec/2013:08:51:10 -0300] [Job 114] PID 3245 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Printer found with device ID: MFG:Canon;CMD:BJ,LQ,BJL,BJRaster,BSCC;MDL:BJC-4200;CLS:PRINTER;DES:Canon BJC-4200; Device URI: usb://Canon/BJC-4200
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Device protocol: 2
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Printer does not like usblp kernel module to be re-attached after job
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Sending data to printer.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Set job-printer-state-message to "Sending data to printer.", current level=INFO
>D [03/Dec/2013:08:51:10 -0300] [Job 114] File contains 1 pages
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Starting renderer with command: gs -dFirstPage=1  -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -dNOINTERPOLATE -sDEVICE=bjc600 -dPrintColors=15 -dProcessColorModel=/DeviceCMYK -dBitsPerPixel=24 -sPrintQuality=Normal -dMediaWeight=80 -sMediaType=PlainPaper -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -r360x360 -sOutputFile=-   /var/spool/cups/tmp/foomatic-XgWbGf 
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Starting process "kid3" (generation 1)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Starting process "kid4" (generation 2)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Starting process "renderer" (generation 2)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] JCL: %-12345X@PJL
>D [03/Dec/2013:08:51:10 -0300] [Job 114] <job data> 
>D [03/Dec/2013:08:51:10 -0300] [Job 114] renderer received signal 11
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Kid3 exit status: 1
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Sent 0 bytes...
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Waiting for read thread to exit...
>D [03/Dec/2013:08:51:10 -0300] [Job 114] PID 3246 (/usr/lib/cups/filter/foomatic-rip) stopped with status 9.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Hint: Try setting the LogLevel to "debug" to find out more.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] Read thread still active, aborting the pending read...
>D [03/Dec/2013:08:51:10 -0300] [Job 114] PID 3247 (/usr/lib/cups/backend/usb) exited with no errors.
>D [03/Dec/2013:08:51:10 -0300] [Job 114] End of messages
>D [03/Dec/2013:08:51:10 -0300] [Job 114] printer-state=3(idle)
>D [03/Dec/2013:08:51:10 -0300] [Job 114] printer-state-message="Filter failed"
>D [03/Dec/2013:08:51:10 -0300] [Job 114] printer-state-reasons=none
>E [03/Dec/2013:08:55:54 -0300] [Job 113] Stopping unresponsive job.
>E [03/Dec/2013:08:56:11 -0300] [Job 114] Stopping unresponsive job.

Actions: View

Attachments on bug 1036428: 831332 | 833114 | 834836