LinuxQuestions.org

LinuxQuestions.org (/questions/)
-   Linux - Server (https://www.linuxquestions.org/questions/linux-server-73/)
-   -   No Output on Printer Using CUPS (https://www.linuxquestions.org/questions/linux-server-73/no-output-on-printer-using-cups-4175493643/)

Stannley 02-04-2014 12:26 AM
No Output on Printer Using CUPS
 
Hi Guys

We have a set of canon iR-ADV C5235 printers that are used in our HQ domain in a queue with authentication based upon our swipe cards.

Unfortunately, our Linux servers are in our PFS domain so cannot access these printers through that queue. Instead, one of the printers has been configured to be accessible from the PFS domain without authentication and without going through the queue. This has been tested from a windows machine in the PFS domain.

I have set the printer up in CUPS using:
socket://172.25.61.210:9100

I downloaded the PPD file from the Canon website.

CUPS appears to see the printer - when print a test page from CUPS or if I print a simple text file from the command line, the job completes successfully with no errors. There is just no output from the printer itself!

Does anyone have any idea what the problem might be, or if the problem might be on the print server / printer end?

We are using Redhat 6.3 and CUPS 1.4.2.

Thanks

Simon

Stannley 02-04-2014 12:27 AM
Debug output
 
I put CUPS into debug mode - here is the output from the last command line job:

Code:
D [04/Feb/2014:11:22:15 +0800] cupsdAcceptClient: skipping getpeercon()
D [04/Feb/2014:11:22:15 +0800] cupsdAcceptClient: 14 from localhost (Domain)
D [04/Feb/2014:11:22:15 +0800] cupsdReadClient: 14 POST / HTTP/1.1
D [04/Feb/2014:11:22:15 +0800] cupsdSetBusyState: Active clients
D [04/Feb/2014:11:22:15 +0800] cupsdAuthorize: No authentication data provided.
D [04/Feb/2014:11:22:15 +0800] cupsdReadClient: 14 1.1 Get-Printer-Attributes 1
D [04/Feb/2014:11:22:15 +0800] Get-Printer-Attributes ipp://localhost:631/printers/TAPS_Printer
D [04/Feb/2014:11:22:15 +0800] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/TAPS_Printer) from localhost
D [04/Feb/2014:11:22:15 +0800] cupsdSetBusyState: Not busy
D [04/Feb/2014:11:22:15 +0800] cupsdReadClient: 14 POST /printers/TAPS_Printer HTTP/1.1
D [04/Feb/2014:11:22:15 +0800] cupsdSetBusyState: Active clients
D [04/Feb/2014:11:22:15 +0800] cupsdAuthorize: No authentication data provided.
D [04/Feb/2014:11:22:15 +0800] cupsdReadClient: 14 1.1 Create-Job 1
D [04/Feb/2014:11:22:15 +0800] Create-Job ipp://localhost:631/printers/TAPS_Printer
D [04/Feb/2014:11:22:15 +0800] add_job: setting context of job to UNKNOWN SL
D [04/Feb/2014:11:22:15 +0800] cupsdMarkDirty(----J-)
D [04/Feb/2014:11:22:15 +0800] cupsdSetBusyState: Active clients and dirty files
D [04/Feb/2014:11:22:15 +0800] add_job: requesting-user-name="simon.tann"
I [04/Feb/2014:11:22:15 +0800] [Job 29] Adding start banner page "none".
D [04/Feb/2014:11:22:15 +0800] Discarding unused job-created event...
I [04/Feb/2014:11:22:15 +0800] [Job 29] Queued on "TAPS_Printer" by "simon.tann".
D [04/Feb/2014:11:22:15 +0800] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/TAPS_Printer) from localhost
D [04/Feb/2014:11:22:15 +0800] cupsdSetBusyState: Dirty files
D [04/Feb/2014:11:22:15 +0800] cupsdReadClient: 14 POST /printers/TAPS_Printer HTTP/1.1
D [04/Feb/2014:11:22:15 +0800] cupsdSetBusyState: Active clients and dirty files
D [04/Feb/2014:11:22:15 +0800] cupsdAuthorize: No authentication data provided.
D [04/Feb/2014:11:22:15 +0800] cupsdReadClient: 14 1.1 Send-Document 1
D [04/Feb/2014:11:22:15 +0800] Send-Document ipp://localhost:631/printers/TAPS_Printer
D [04/Feb/2014:11:22:15 +0800] cupsdIsAuthorized: requesting-user-name="simon.tann"
D [04/Feb/2014:11:22:15 +0800] [Job 29] Auto-typing file...
D [04/Feb/2014:11:22:15 +0800] [Job 29] Request file type is text/plain.
D [04/Feb/2014:11:22:15 +0800] cupsdMarkDirty(----J-)
I [04/Feb/2014:11:22:15 +0800] [Job 29] File of type text/plain queued by "simon.tann".
I [04/Feb/2014:11:22:15 +0800] [Job 29] Adding end banner page "none".
D [04/Feb/2014:11:22:15 +0800] cupsdMarkDirty(----J-)
D [04/Feb/2014:11:22:15 +0800] cupsdMarkDirty(----J-)
D [04/Feb/2014:11:22:15 +0800] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [04/Feb/2014:11:22:15 +0800] Discarding unused printer-state-changed event...
D [04/Feb/2014:11:22:15 +0800] [Job 29] job-sheets=none,none
D [04/Feb/2014:11:22:15 +0800] [Job 29] argv[0]="TAPS_Printer"
D [04/Feb/2014:11:22:15 +0800] [Job 29] argv[1]="29"
D [04/Feb/2014:11:22:15 +0800] [Job 29] argv[2]="simon.tann"
D [04/Feb/2014:11:22:15 +0800] [Job 29] argv[3]="test.txt"
D [04/Feb/2014:11:22:15 +0800] [Job 29] argv[4]="1"
D [04/Feb/2014:11:22:15 +0800] [Job 29] argv[5]="finishings=3 media=iso_a4_210x297mm number-up=1 sides=two-sided-long-edge job-uuid=urn:uuid:0142e3a1-ae44-369a-6e76-2a0f1220c27b job-originating-host-name=localhost"
D [04/Feb/2014:11:22:15 +0800] [Job 29] argv[6]="/var/spool/cups/d00029-001"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[8]="HOME=/var/spool/cups/tmp"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[10]="SERVER_ADMIN=root@sdvx10600.pfs.com.au"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[11]="SOFTWARE=CUPS/1.4.2"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[13]="USER=root"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[16]="IPP_PORT=631"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[17]="CHARSET=utf-8"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[18]="LANG=en_US.UTF-8"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[19]="PPD=/etc/cups/ppd/TAPS_Printer.ppd"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[20]="RIP_MAX_CACHE=128m"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[21]="CONTENT_TYPE=text/plain"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[22]="DEVICE_URI=socket://172.25.61.210:9100"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[23]="PRINTER_INFO=Canon Printer for TAPS"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[24]="PRINTER_LOCATION=Compactus Area"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[25]="PRINTER=TAPS_Printer"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[26]="CUPS_FILETYPE=document"
D [04/Feb/2014:11:22:15 +0800] [Job 29] envp[27]="FINAL_CONTENT_TYPE=printer/TAPS_Printer"
I [04/Feb/2014:11:22:15 +0800] [Job 29] Started filter /usr/lib/cups/filter/texttopaps (PID 30665)
I [04/Feb/2014:11:22:15 +0800] [Job 29] Started filter /usr/lib/cups/filter/pstops (PID 30666)
I [04/Feb/2014:11:22:15 +0800] [Job 29] Started filter /usr/lib/cups/filter/foomatic-rip (PID 30667)
I [04/Feb/2014:11:22:15 +0800] [Job 29] Started backend /usr/lib/cups/backend/socket (PID 30668)
D [04/Feb/2014:11:22:15 +0800] Discarding unused job-state-changed event...
D [04/Feb/2014:11:22:15 +0800] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/TAPS_Printer) from localhost
D [04/Feb/2014:11:22:15 +0800] cupsdSetBusyState: Printing jobs and dirty files
D [04/Feb/2014:11:22:15 +0800] cupsdReadClient: 14 WAITING Closing on EOF
D [04/Feb/2014:11:22:15 +0800] cupsdCloseClient: 14
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: +connecting-to-device
D [04/Feb/2014:11:22:15 +0800] [Job 29] Looking up "172.25.61.210"...
D [04/Feb/2014:11:22:15 +0800] Discarding unused printer-state-changed event...
D [04/Feb/2014:11:22:15 +0800] [Job 29] Connecting to 172.25.61.210:9100
I [04/Feb/2014:11:22:15 +0800] [Job 29] Connecting to printer...
D [04/Feb/2014:11:22:15 +0800] Discarding unused printer-state-changed event...
D [04/Feb/2014:11:22:15 +0800] Discarding unused job-progress event...
D [04/Feb/2014:11:22:15 +0800] [Job 29] Getting input from file
D [04/Feb/2014:11:22:15 +0800] [Job 29] foomatic-rip version 4.0.4.217 running...
D [04/Feb/2014:11:22:15 +0800] [Job 29] Parsing PPD file ...
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Opt2CF
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option OptSPD
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option OptENV
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option OptFIN
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option OptCTRY
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option OptPCU
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option OptSecure
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Destination
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Mailbox
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option UserPassword
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option UserID
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option SecuredPassword
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option RepeatJob
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option InputSlot
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option MediaType
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Resolution
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Duplex
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option TSwitch
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Booklet
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option BindMode
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Creep
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option BindingLocation
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Gutter
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Finishing
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option ShiftUnit
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Interleave
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Staple
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Punch
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option CNOutput
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option UseSecure
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option ShiftFrontUD
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option ShiftFrontLR
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option ShiftBackUD
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option ShiftBackLR
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option CN_DPI
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option ComposOverprint
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option SpotColorMatch
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option GSmooth
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Gscale
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Trapping
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option TonerSave
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option AdvancedSmooth
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Sharpness
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option ImageCompress
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option TonerAdjust
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option LineCont
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option DensityFineAdjust
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option CNBrightness
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option HalfTone
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option ColorModel
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option PureBlack
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option BlackOver
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option MTCRGB
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option RGBSP
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Matching
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option CNRGBPBP
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option RGBInput
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option MTCCMYK
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Simulation
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option CNCMYKPBP
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option CMYKInput
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option GrayProfile
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option OutputProfile
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option HalftoneType
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option ScreenProc
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Transfer
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option LeadingEdge
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option PageSize
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option ImageableArea
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option PaperDimension
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option Font
D [04/Feb/2014:11:22:15 +0800] [Job 29] Added option ColorSep
D [04/Feb/2014:11:22:15 +0800] [Job 29]
D [04/Feb/2014:11:22:15 +0800] [Job 29] Parameter Summary
D [04/Feb/2014:11:22:15 +0800] [Job 29] -----------------
D [04/Feb/2014:11:22:15 +0800] [Job 29]
D [04/Feb/2014:11:22:15 +0800] [Job 29] Spooler: cups
D [04/Feb/2014:11:22:15 +0800] [Job 29] Printer: TAPS_Printer
D [04/Feb/2014:11:22:15 +0800] [Job 29] Shell: /bin/bash
D [04/Feb/2014:11:22:15 +0800] [Job 29] PPD file: /etc/cups/ppd/TAPS_Printer.ppd
D [04/Feb/2014:11:22:15 +0800] [Job 29] ATTR file:
D [04/Feb/2014:11:22:15 +0800] [Job 29] Printer model: Canon iR-ADV C5235/5240 PS
D [04/Feb/2014:11:22:15 +0800] [Job 29] Job title: test.txt
D [04/Feb/2014:11:22:15 +0800] [Job 29] File(s) to be printed:
D [04/Feb/2014:11:22:15 +0800] [Job 29] <STDIN>
D [04/Feb/2014:11:22:15 +0800] [Job 29]
D [04/Feb/2014:11:22:15 +0800] [Job 29] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [04/Feb/2014:11:22:15 +0800] [Job 29] Printing system options:
D [04/Feb/2014:11:22:15 +0800] [Job 29] Pondering option 'finishings=3'
D [04/Feb/2014:11:22:15 +0800] [Job 29] Unknown option finishings=3.
D [04/Feb/2014:11:22:15 +0800] [Job 29] Pondering option 'media=iso_a4_210x297mm'
D [04/Feb/2014:11:22:15 +0800] [Job 29] Unknown "media" component: "iso_a4_210x297mm".
D [04/Feb/2014:11:22:15 +0800] [Job 29] Pondering option 'number-up=1'
D [04/Feb/2014:11:22:15 +0800] [Job 29] Unknown option number-up=1.
D [04/Feb/2014:11:22:15 +0800] [Job 29] Pondering option 'sides=two-sided-long-edge'
D [04/Feb/2014:11:22:15 +0800] [Job 29] Pondering option 'job-uuid=urn:uuid:0142e3a1-ae44-369a-6e76-2a0f1220c27b'
D [04/Feb/2014:11:22:15 +0800] [Job 29] Unknown option job-uuid=urn:uuid:0142e3a1-ae44-369a-6e76-2a0f1220c27b.
D [04/Feb/2014:11:22:15 +0800] [Job 29] Pondering option 'job-originating-host-name=localhost'
D [04/Feb/2014:11:22:15 +0800] [Job 29] Unknown option job-originating-host-name=localhost.
D [04/Feb/2014:11:22:15 +0800] [Job 29] Options from the PPD file:
D [04/Feb/2014:11:22:15 +0800] [Job 29]
D [04/Feb/2014:11:22:15 +0800] [Job 29] ================================================
D [04/Feb/2014:11:22:15 +0800] [Job 29]
D [04/Feb/2014:11:22:15 +0800] [Job 29] File: <STDIN>
D [04/Feb/2014:11:22:15 +0800] [Job 29]
D [04/Feb/2014:11:22:15 +0800] [Job 29] ================================================
D [04/Feb/2014:11:22:15 +0800] [Job 29]
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -connecting-to-device
I [04/Feb/2014:11:22:15 +0800] [Job 29] Connected to printer...
D [04/Feb/2014:11:22:15 +0800] [Job 29] Connected to 172.25.61.210:9100 (IPv4)...
D [04/Feb/2014:11:22:15 +0800] Discarding unused printer-state-changed event...
D [04/Feb/2014:11:22:15 +0800] Discarding unused job-progress event...
D [04/Feb/2014:11:22:15 +0800] [Job 29] ATTR: marker-colors=#000000,#00FFFF,#FF00FF,#FFFF00,none
D [04/Feb/2014:11:22:15 +0800] cupsdMarkDirty(P-----)
D [04/Feb/2014:11:22:15 +0800] [Job 29] ATTR: marker-names="Canon NPG-46 Black Toner","Canon NPG-46 Cyan Toner","Canon NPG-46 Magenta Toner","Canon NPG-46 Yellow Toner","Waste Toner"
D [04/Feb/2014:11:22:15 +0800] cupsdMarkDirty(P-----)
D [04/Feb/2014:11:22:15 +0800] [Job 29] ATTR: marker-types=toner,toner,toner,toner,wasteToner
D [04/Feb/2014:11:22:15 +0800] cupsdMarkDirty(P-----)
D [04/Feb/2014:11:22:15 +0800] [Job 29] ATTR: marker-levels=75,94,83,84,-1
D [04/Feb/2014:11:22:15 +0800] cupsdMarkDirty(P-----)
D [04/Feb/2014:11:22:15 +0800] Discarding unused printer-state-changed event...
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -media-low-report
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -media-empty-warning
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -toner-low-report
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -toner-empty-warning
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -door-open-report
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -media-jam-warning
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -input-tray-missing-warning
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -output-tray-missing-warning
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -marker-supply-missing-warning
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -output-area-almost-full-report
D [04/Feb/2014:11:22:15 +0800] [Job 29] STATE: -output-area-full-warning
D [04/Feb/2014:11:22:15 +0800] [Job 29] backendRunLoop(print_fd=0, device_fd=5, snmp_fd=6, addr=0x7f1b43c0d988, use_bc=1, side_cb=0x7f1b42148d50)
D [04/Feb/2014:11:22:17 +0800] PID 30665 (/usr/lib/cups/filter/texttopaps) exited with no errors.
D [04/Feb/2014:11:22:17 +0800] [Job 29] Page = 595x842; 11,11 to 584,831
D [04/Feb/2014:11:22:17 +0800] [Job 29] slow_collate=0, slow_duplex=0, slow_order=0
D [04/Feb/2014:11:22:17 +0800] [Job 29] Before copy_comments - %!PS-Adobe-3.0
D [04/Feb/2014:11:22:17 +0800] [Job 29] %!PS-Adobe-3.0
D [04/Feb/2014:11:22:17 +0800] [Job 29] %cupsRotation: 0
D [04/Feb/2014:11:22:17 +0800] [Job 29] %%Title: test.txt
D [04/Feb/2014:11:22:17 +0800] [Job 29] %%Creator: paps version 0.6.7 by Dov Grobgeld
D [04/Feb/2014:11:22:17 +0800] [Job 29] %%Pages: (atend)
D [04/Feb/2014:11:22:17 +0800] [Job 29] %%BoundingBox: 0 0 595 842
D [04/Feb/2014:11:22:17 +0800] [Job 29] %%For: simon.tann
D [04/Feb/2014:11:22:17 +0800] [Job 29] %%Orientation: Portrait
D [04/Feb/2014:11:22:17 +0800] [Job 29] %%EndComments
D [04/Feb/2014:11:22:17 +0800] [Job 29] Before copy_prolog - %%BeginProlog
D [04/Feb/2014:11:22:17 +0800] [Job 29] Before copy_setup - %%BeginSetup
D [04/Feb/2014:11:22:17 +0800] [Job 29] Before page loop - %%Page: 1 1
D [04/Feb/2014:11:22:17 +0800] [Job 29] Copying page 1...
D [04/Feb/2014:11:22:17 +0800] [Job 29] pagew = 572.3, pagel = 819.3
D [04/Feb/2014:11:22:17 +0800] [Job 29] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [04/Feb/2014:11:22:17 +0800] [Job 29] PageLeft = 11.3, PageRight = 583.7
D [04/Feb/2014:11:22:17 +0800] [Job 29] PageTop = 830.7, PageBottom = 11.3
D [04/Feb/2014:11:22:17 +0800] [Job 29] PageWidth = 595.0, PageLength = 842.0
D [04/Feb/2014:11:22:17 +0800] [Job 29] Wrote 1 pages...

Stannley 02-04-2014 12:29 AM
Debug Output Part 2
 
Code:
D [04/Feb/2014:11:22:17 +0800] [Job 29] Filetype: PostScript
D [04/Feb/2014:11:22:17 +0800] [Job 29] Reading PostScript input ...
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> This document is DSC-conforming!
D [04/Feb/2014:11:22:17 +0800] PID 30666 (/usr/lib/cups/filter/pstops) exited with no errors.
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found %RBINumCopies: 1
D [04/Feb/2014:11:22:17 +0800] [Job 29]
D [04/Feb/2014:11:22:17 +0800] [Job 29] -----------
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginProlog
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%EndProlog
D [04/Feb/2014:11:22:17 +0800] [Job 29]
D [04/Feb/2014:11:22:17 +0800] [Job 29] -----------
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginSetup
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Opt2CF False
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Opt2CF=False
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *OptCTRY False
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: OptCTRY=False
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *OptENV False
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: OptENV=False
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *OptFIN None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: OptFIN=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *OptPCU False
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: OptPCU=False
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *OptSPD False
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: OptSPD=False
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *OptSecure False
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: OptSecure=False
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Booklet Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Booklet=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Destination Printer
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Destination=Printer
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %% FoomaticRIPOptionSetting: Destination=Printer
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Destination=Printer
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *RepeatJob None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: RepeatJob=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %% FoomaticRIPOptionSetting: RepeatJob=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: RepeatJob=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *SecuredPassword None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: SecuredPassword=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %% FoomaticRIPOptionSetting: SecuredPassword=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: SecuredPassword=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *UserID None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: UserID=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %% FoomaticRIPOptionSetting: UserID=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: UserID=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *UserPassword None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: UserPassword=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %% FoomaticRIPOptionSetting: UserPassword=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: UserPassword=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Mailbox None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Mailbox=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %% FoomaticRIPOptionSetting: Mailbox=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Mailbox=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Setting option
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *InputSlot Auto
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: InputSlot=Auto
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Duplex DuplexNoTumble
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Duplex=DuplexNoTumble
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Finishing Col
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Finishing=Col
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *GSmooth Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: GSmooth=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *GrayProfile Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: GrayProfile=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Gscale Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Gscale=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Gutter None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Gutter=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *HalfTone Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: HalfTone=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *ImageCompress Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: ImageCompress=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *BindingLocation None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: BindingLocation=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *LineCont Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: LineCont=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *MTCCMYK Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: MTCCMYK=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *MTCRGB Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: MTCRGB=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *BlackOver Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: BlackOver=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *MediaType None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: MediaType=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *AdvancedSmooth Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: AdvancedSmooth=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *CMYKInput Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: CMYKInput=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *CNBrightness Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: CNBrightness=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *CNCMYKPBP Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: CNCMYKPBP=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *CNOutput Auto
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: CNOutput=Auto
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *CNRGBPBP Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: CNRGBPBP=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *ColorModel Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: ColorModel=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *PageRegion A4
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: PageRegion=A4
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Punch None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Punch=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *PureBlack Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: PureBlack=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *RGBInput Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: RGBInput=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *RGBSP Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: RGBSP=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *ComposOverprint Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: ComposOverprint=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Creep Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Creep=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Sharpness Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Sharpness=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *ShiftBackLR None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: ShiftBackLR=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *ShiftBackUD None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: ShiftBackUD=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *ShiftFrontLR None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: ShiftFrontLR=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *ShiftFrontUD None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: ShiftFrontUD=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *ShiftUnit Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: ShiftUnit=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *SpotColorMatch Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: SpotColorMatch=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Staple None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Staple=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *TSwitch Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: TSwitch=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *TonerAdjust Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: TonerAdjust=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *TonerSave Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: TonerSave=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Trapping Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Trapping=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *UseSecure Off
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: UseSecure=Off
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *DensityFineAdjust Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: DensityFineAdjust=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *BindMode Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: BindMode=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Simulation Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Simulation=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *OutputProfile Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: OutputProfile=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *CN_DPI 600dpi
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: CN_DPI=600dpi
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Interleave None
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Interleave=None
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginFeature: *Matching Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] Option: Matching=Default
D [04/Feb/2014:11:22:17 +0800] [Job 29] --> Option will be set by PostScript interpreter
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%EndSetup
D [04/Feb/2014:11:22:17 +0800] [Job 29] Inserting PostScript code for CUPS' page accounting
D [04/Feb/2014:11:22:17 +0800] [Job 29]
D [04/Feb/2014:11:22:17 +0800] [Job 29] -----------
D [04/Feb/2014:11:22:17 +0800] [Job 29] New page: %%Page: 1 1
D [04/Feb/2014:11:22:17 +0800] [Job 29]
D [04/Feb/2014:11:22:17 +0800] [Job 29] Found: %%BeginPageSetup
D [04/Feb/2014:11:22:17 +0800] [Job 29] Inserting option code into "PageSetup" section.
D [04/Feb/2014:11:22:17 +0800] [Job 29] Flushing FIFO.
D [04/Feb/2014:11:22:18 +0800] [Job 29]
D [04/Feb/2014:11:22:18 +0800] [Job 29] Starting renderer with command: "/bin/cat - | sicgsfilter -MPS -NP  -A1 -usimon.tann -V"test.txt" -n1 "
D [04/Feb/2014:11:22:18 +0800] [Job 29] Starting process "kid3" (generation 1)
D [04/Feb/2014:11:22:18 +0800] [Job 29]
D [04/Feb/2014:11:22:18 +0800] [Job 29] Closing renderer
D [04/Feb/2014:11:22:18 +0800] [Job 29] Starting process "kid4" (generation 2)
D [04/Feb/2014:11:22:18 +0800] [Job 29] Starting process "renderer" (generation 2)
D [04/Feb/2014:11:22:18 +0800] [Job 29] JCL: %-12345X@PJL
D [04/Feb/2014:11:22:18 +0800] [Job 29] <job data>
D [04/Feb/2014:11:22:18 +0800] [Job 29]
D [04/Feb/2014:11:22:18 +0800] [Job 29] Read 8192 bytes of print data...
D [04/Feb/2014:11:22:18 +0800] [Job 29] renderer exited with status 0
D [04/Feb/2014:11:22:18 +0800] [Job 29] kid4 exited with status 0
D [04/Feb/2014:11:22:18 +0800] [Job 29] kid3 finished
D [04/Feb/2014:11:22:18 +0800] [Job 29] kid3 exited with status 0
D [04/Feb/2014:11:22:18 +0800] [Job 29]
D [04/Feb/2014:11:22:18 +0800] [Job 29] Closing foomatic-rip.
D [04/Feb/2014:11:22:18 +0800] PID 30667 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.
D [04/Feb/2014:11:22:18 +0800] [Job 29] ATTR: marker-levels=40,75,66,65,-1
D [04/Feb/2014:11:22:18 +0800] cupsdMarkDirty(P-----)
D [04/Feb/2014:11:22:18 +0800] Discarding unused printer-state-changed event...
D [04/Feb/2014:11:22:18 +0800] [Job 29] Wrote 8192 bytes of print data...
D [04/Feb/2014:11:22:18 +0800] [Job 29] Read 8192 bytes of print data...
D [04/Feb/2014:11:22:19 +0800] [Job 29] Wrote 8192 bytes of print data...
D [04/Feb/2014:11:22:19 +0800] [Job 29] Read 8192 bytes of print data...
D [04/Feb/2014:11:22:19 +0800] [Job 29] Wrote 8192 bytes of print data...
D [04/Feb/2014:11:22:19 +0800] [Job 29] Read 798 bytes of print data...
D [04/Feb/2014:11:22:19 +0800] [Job 29] Wrote 798 bytes of print data...
I [04/Feb/2014:11:22:19 +0800] [Job 29] Print file sent, waiting for printer to finish...
D [04/Feb/2014:11:22:19 +0800] Discarding unused printer-state-changed event...
D [04/Feb/2014:11:22:19 +0800] Discarding unused job-progress event...
D [04/Feb/2014:11:22:19 +0800] [Job 29] ATTR: marker-levels=40,75,66,65,-1
D [04/Feb/2014:11:22:19 +0800] cupsdMarkDirty(P-----)
D [04/Feb/2014:11:22:19 +0800] Discarding unused printer-state-changed event...
I [04/Feb/2014:11:22:19 +0800] [Job 29] Ready to print.
D [04/Feb/2014:11:22:19 +0800] Discarding unused printer-state-changed event...
D [04/Feb/2014:11:22:19 +0800] Discarding unused job-progress event...
D [04/Feb/2014:11:22:19 +0800] PID 30668 (/usr/lib/cups/backend/socket) exited with no errors.
D [04/Feb/2014:11:22:19 +0800] Discarding unused job-completed event...
I [04/Feb/2014:11:22:19 +0800] [Job 29] Job completed.
D [04/Feb/2014:11:22:19 +0800] cupsdMarkDirty(----J-)
D [04/Feb/2014:11:22:19 +0800] Discarding unused printer-state-changed event...
D [04/Feb/2014:11:22:20 +0800] [Job 29] Unloading...
Sorry for the break in the debug info - ran afoul of the message limit.

Stannley 02-09-2014 06:08 PM
No Replies
 
Hi Guys

I was wondering if anyone had any thoughts on this issue?

Cheers


All times are GMT -5. The time now is 04:39 PM.