Attachment 299350 Details for Bug 439154 – debugjob18.txt

debugjob18.txt

cups-smb-sharedwinprint.txt (text/plain), 24.79 KB, created by Darwin H. Webb on 2008-03-27 16:02:10 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Darwin H. Webb

Created: 2008-03-27 16:02:10 UTC

Size: 24.79 KB

patch

obsolete

>D [27/Mar/2008:08:50:00 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:00 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:00 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:00 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:00 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:00 -0700] Get-Jobs ipp://localhost/jobs/
>D [27/Mar/2008:08:50:00 -0700] [Job 17] Loading attributes...
>D [27/Mar/2008:08:50:00 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:00 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:00 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:00 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:00 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:00 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:00 -0700] Create-Printer-Subscription /
>D [27/Mar/2008:08:50:00 -0700] cupsdCreateSubscription(con=0xb86299f0(13), uri="/")
>D [27/Mar/2008:08:50:00 -0700] pullmethod="ippget"
>D [27/Mar/2008:08:50:00 -0700] notify-lease-duration=86400
>D [27/Mar/2008:08:50:00 -0700] notify-time-interval=0
>D [27/Mar/2008:08:50:00 -0700] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")
>D [27/Mar/2008:08:50:00 -0700] Added subscription 8 for server
>I [27/Mar/2008:08:50:00 -0700] Saving subscriptions.conf...
>D [27/Mar/2008:08:50:00 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:00 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:01 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:01 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:01 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:01 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:01 -0700] Get-Notifications /
>D [27/Mar/2008:08:50:01 -0700] cupsdIsAuthorized: requesting-user-name="darwinhwebb"
>D [27/Mar/2008:08:50:01 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:01 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:19 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:19 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:19 -0700] cupsdReadClient: 13 POST /printers/LaserJet_6P HTTP/1.1
>D [27/Mar/2008:08:50:19 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:19 -0700] Print-Job ipp://localhost/printers/LaserJet_6P
>D [27/Mar/2008:08:50:19 -0700] add_job: setting context of job to UNKNOWN SL
>D [27/Mar/2008:08:50:19 -0700] add_job: requesting-user-name="darwinhwebb"
>D [27/Mar/2008:08:50:19 -0700] Adding default job-sheets values "none,none"...
>I [27/Mar/2008:08:50:19 -0700] [Job 18] Adding start banner page "none".
>I [27/Mar/2008:08:50:19 -0700] Saving subscriptions.conf...
>I [27/Mar/2008:08:50:19 -0700] [Job 18] Adding job file of type application/postscript.
>I [27/Mar/2008:08:50:19 -0700] [Job 18] Adding end banner page "none".
>I [27/Mar/2008:08:50:19 -0700] [Job 18] Queued on "LaserJet_6P" by "darwinhwebb".
>D [27/Mar/2008:08:50:19 -0700] [Job 18] hold_until = 0
>I [27/Mar/2008:08:50:19 -0700] Saving subscriptions.conf...
>D [27/Mar/2008:08:50:19 -0700] [Job 18] job-sheets=none,none
>D [27/Mar/2008:08:50:19 -0700] [Job 18] banner_page = 0
>D [27/Mar/2008:08:50:19 -0700] [Job 18] argv[0]="LaserJet_6P"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] argv[1]="18"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] argv[2]="darwinhwebb"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] argv[3]="Test Page"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] argv[4]="1"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] argv[5]="job-uuid=urn:uuid:5463429a-64fc-3b15-6d08-4dfc2757011d"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] argv[6]="/var/spool/cups/d00018-001"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[1]="CUPS_DATADIR=/usr/share/cups"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[6]="CUPS_SERVERROOT=/etc/cups"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[7]="CUPS_STATEDIR=/var/run/cups"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[9]="SERVER_ADMIN=root@Tasha-19.WinProxy"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[10]="SOFTWARE=CUPS/1.3.6"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[11]="TMPDIR=/var/spool/cups/tmp"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[12]="USER=root"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[13]="CUPS_SERVER=/var/run/cups/cups.sock"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[14]="CUPS_ENCRYPTION=IfRequested"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[15]="IPP_PORT=631"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[16]="CHARSET=utf-8"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[17]="LANG=en_US.UTF8"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[18]="PPD=/etc/cups/ppd/LaserJet_6P.ppd"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[19]="RIP_MAX_CACHE=8m"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[20]="CONTENT_TYPE=application/postscript"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[21]="DEVICE_URI=smb:///URANUS-37/HPLaserJ.2"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[22]="PRINTER=LaserJet_6P"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] envp[23]="FINAL_CONTENT_TYPE=printer/LaserJet_6P"
>I [27/Mar/2008:08:50:19 -0700] [Job 18] Started filter /usr/lib/cups/filter/pstops (PID 8892)
>I [27/Mar/2008:08:50:19 -0700] [Job 18] Started filter /usr/lib/cups/filter/foomatic-rip (PID 8893)
>I [27/Mar/2008:08:50:19 -0700] [Job 18] Started backend /usr/lib/cups/backend/smb (PID 8894)
>I [27/Mar/2008:08:50:19 -0700] Saving subscriptions.conf...
>D [27/Mar/2008:08:50:19 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:19 -0700] PID 8892 (/usr/lib/cups/filter/pstops) exited with no errors.
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Page = 612x792; 18,14 to 594,778
>D [27/Mar/2008:08:50:19 -0700] [Job 18] slow_collate=0, slow_duplex=0, slow_order=0
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Before copy_comments - %!PS-Adobe-3.0
>D [27/Mar/2008:08:50:19 -0700] [Job 18] %!PS-Adobe-3.0
>D [27/Mar/2008:08:50:19 -0700] [Job 18] %%BoundingBox: 0 0 612 792
>D [27/Mar/2008:08:50:19 -0700] [Job 18] %%Pages: 1
>D [27/Mar/2008:08:50:19 -0700] [Job 18] %%LanguageLevel: 1
>D [27/Mar/2008:08:50:19 -0700] [Job 18] %%DocumentData: Clean7Bit
>D [27/Mar/2008:08:50:19 -0700] [Job 18] %%DocumentSuppliedResources: procset testprint/1.3
>D [27/Mar/2008:08:50:19 -0700] [Job 18] %%DocumentNeededResources: font Helvetica Helvetica-Bold Times-Roman
>D [27/Mar/2008:08:50:19 -0700] [Job 18] %%Creator: Michael Sweet, Apple Inc.
>D [27/Mar/2008:08:50:19 -0700] [Job 18] %%CreationDate: D:20070606214000+0500
>D [27/Mar/2008:08:50:19 -0700] [Job 18] %%Title: Test Page
>D [27/Mar/2008:08:50:19 -0700] [Job 18] %%EndComments
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Before copy_prolog - %%BeginProlog
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Before copy_setup - %%Page: 1 1
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Before page loop - %%Page: 1 1
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Copying page 1...
>D [27/Mar/2008:08:50:19 -0700] [Job 18] pagew = 576.0, pagel = 763.2
>D [27/Mar/2008:08:50:19 -0700] [Job 18] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
>D [27/Mar/2008:08:50:19 -0700] [Job 18] PageLeft = 18.0, PageRight = 594.0
>D [27/Mar/2008:08:50:19 -0700] [Job 18] PageTop = 777.6, PageBottom = 14.4
>D [27/Mar/2008:08:50:19 -0700] [Job 18] PageWidth = 612.0, PageLength = 792.0
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Wrote 1 pages...
>D [27/Mar/2008:08:50:19 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:19 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:19 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:19 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:19 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:19 -0700] Get-Notifications /
>D [27/Mar/2008:08:50:19 -0700] cupsdIsAuthorized: requesting-user-name="darwinhwebb"
>D [27/Mar/2008:08:50:19 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:19 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:19 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:19 -0700] Get-Job-Attributes ipp://localhost/jobs/18
>D [27/Mar/2008:08:50:19 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:19 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:19 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:19 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:19 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:19 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:19 -0700] Get-Notifications /
>D [27/Mar/2008:08:50:19 -0700] cupsdIsAuthorized: requesting-user-name="darwinhwebb"
>D [27/Mar/2008:08:50:19 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:19 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:19 -0700] [Job 18] foomatic-rip version $Revision$ running...
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Parsing PPD file ...
>D [27/Mar/2008:08:50:19 -0700] [Job 18] *cupsFilter: "application/vnd.cups-postscript 0 foomatic-rip"
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Added option ColorSpace
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Added option Resolution
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Added option PageSize
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Added option PageRegion
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Added option Model
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Added option PrintoutMode
>D [27/Mar/2008:08:50:19 -0700] [Job 18] Added option InputSlot
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Added option ImageableArea
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Added option PaperDimension
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Added option Duplex
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Added option Quality
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Added option Font
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Parameter Summary
>D [27/Mar/2008:08:50:20 -0700] [Job 18] -----------------
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Spooler: cups
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Printer: LaserJet_6P
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Shell: /bin/sh
>D [27/Mar/2008:08:50:20 -0700] [Job 18] PPD file: /etc/cups/ppd/LaserJet_6P.ppd
>D [27/Mar/2008:08:50:20 -0700] [Job 18] ATTR file:
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Printer model: HP LaserJet 6P Foomatic/hpijs (recommended)
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Job title: Test Page
>D [27/Mar/2008:08:50:20 -0700] [Job 18] File(s) to be printed:
>D [27/Mar/2008:08:50:20 -0700] [Job 18] <STDIN>
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] GhostScript extra search path ('GS_LIB'): /usr/share/cups/fonts
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Pondering option 'job-uuid=urn:uuid:5463429a-64fc-3b15-6d08-4dfc2757011d'
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Unknown option job-uuid=urn:uuid:5463429a-64fc-3b15-6d08-4dfc2757011d.
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] ================================================
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] File: <STDIN>
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] ================================================
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Reading PostScript input ...
>D [27/Mar/2008:08:50:20 -0700] [Job 18] --> This document is DSC-conforming!
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] -----------
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%BeginProlog
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%EndProlog
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] -----------
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%BeginSetup
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%BeginFeature: *PrintoutMode Normal
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Option: PrintoutMode=Normal --> Setting option
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %% FoomaticRIPOptionSetting: PrintoutMode=Normal
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Option: PrintoutMode=Normal --> Setting option
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%BeginFeature: *InputSlot Default
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Option: InputSlot=Default --> Setting option
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %% FoomaticRIPOptionSetting: InputSlot=Default
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Option: InputSlot=Default --> Setting option
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%BeginFeature: *Quality FromPrintoutMode
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Option: Quality=FromPrintoutMode --> Setting option
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %% FoomaticRIPOptionSetting: Quality=@PrintoutMode
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Option: Quality=FromPrintoutMode --> Setting option
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%BeginFeature: *PageRegion Letter
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Option: PageRegion=Letter --> Option will be set by PostScript interpreter
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %% FoomaticRIPOptionSetting: PageSize=Letter
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Option: PageSize=Letter --> Setting option
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%BeginFeature: *Duplex None
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Option: Duplex=None --> Setting option
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %% FoomaticRIPOptionSetting: Duplex=None
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Option: Duplex=None --> Setting option
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%EndSetup
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Inserting PostScript code for CUPS' page accounting
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] -----------
>D [27/Mar/2008:08:50:20 -0700] [Job 18] New page:  1 1
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Inserting option code into "PageSetup" section.
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%BeginPageSetup
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%EndPageSetup
>D [27/Mar/2008:08:50:20 -0700] [Job 18] End of page header
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Stopping search for page header options
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found:       lineto				% Move there...
>D [27/Mar/2008:08:50:20 -0700] [Job 18] --> Output goes directly to the renderer now.
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Starting renderer
>D [27/Mar/2008:08:50:20 -0700] [Job 18] JCL: <job data>
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%Trailer
>D [27/Mar/2008:08:50:20 -0700] [Job 18] --> Continue DSC parsing now.
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] renderer PID kid4=8899
>D [27/Mar/2008:08:50:20 -0700] [Job 18] renderer command: gs -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -sDEVICE=ijs -sIjsServer=hpijs -sDeviceManufacturer="HEWLETT-PACKARD" -sDeviceModel="HP LaserJet" -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -dDuplex=false -r300 -sIjsParams=Quality:Quality=0,Quality:ColorMode=0,Quality:MediaType=0,Quality:PenSet=0,PS:MediaPosition=7 -dIjsUseOutputFD -sOutputFile=- -
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%Pages: 1
>D [27/Mar/2008:08:50:20 -0700] [Job 18] --> Continue DSC parsing now.
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%BoundingBox: 0 0 612 792
>D [27/Mar/2008:08:50:20 -0700] [Job 18] --> Continue DSC parsing now.
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Found: %%EOF
>D [27/Mar/2008:08:50:20 -0700] [Job 18] --> Continue DSC parsing now.
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18]
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Closing renderer
>D [27/Mar/2008:08:50:20 -0700] [Job 18] Starting process 8900: "foomatic-gswrapper -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -sDEVICE=ijs -sIjsServer=hpijs -sDev..."
>D [27/Mar/2008:08:50:20 -0700] [Job 18] foomatic-gswrapper: gs '-sstdout=%stderr' '-dBATCH' '-dPARANOIDSAFER' '-dQUIET' '-dNOPAUSE' '-sDEVICE=ijs' '-sIjsServer=hpijs' '-sDeviceManufacturer=HEWLETT-PACKARD' '-sDeviceModel=HP LaserJet' '-dDEVICEWIDTHPOINTS=612' '-dDEVICEHEIGHTPOINTS=792' '-dDuplex=false' '-r300' '-sIjsParams=Quality:Quality=0,Quality:ColorMode=0,Quality:MediaType=0,Quality:PenSet=0,PS:MediaPosition=7' '-dIjsUseOutputFD' '-sOutputFile=%stdout' '-_'
>I [27/Mar/2008:08:50:21 -0700] Saving subscriptions.conf...
>E [27/Mar/2008:08:50:21 -0700] [Job 18] Error writing spool: ERRSRV - ERRerror (Non-specific error code.)
>I [27/Mar/2008:08:50:21 -0700] Saving subscriptions.conf...
>D [27/Mar/2008:08:50:21 -0700] PID 8894 (/usr/lib/cups/backend/smb) exited with no errors.
>D [27/Mar/2008:08:50:21 -0700] [Job 18] Process dying with "Caught termination signal: Job canceled", exit stat: 0
>D [27/Mar/2008:08:50:21 -0700] [Job 18] error: Broken pipe (32)
>D [27/Mar/2008:08:50:21 -0700] [Job 18] Cleaning up ...
>D [27/Mar/2008:08:50:21 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:21 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:21 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:21 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:21 -0700] Get-Notifications /
>D [27/Mar/2008:08:50:21 -0700] cupsdIsAuthorized: requesting-user-name="darwinhwebb"
>D [27/Mar/2008:08:50:21 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:21 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:21 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:21 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:21 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:21 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:21 -0700] Get-Notifications /
>D [27/Mar/2008:08:50:21 -0700] cupsdIsAuthorized: requesting-user-name="darwinhwebb"
>D [27/Mar/2008:08:50:21 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:21 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:24 -0700] [Job 18]
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Closing foomatic-rip.
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Error: /ioerror in --showpage--
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Operand stack:
>D [27/Mar/2008:08:50:24 -0700] [Job 18] 1   true
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Execution stack:
>D [27/Mar/2008:08:50:24 -0700] [Job 18] %interp_exit   .runexec2   --nostringval--   --nostringval--   --nostringval--   2   %stopped_push   --nostringval--   --nostringval--   --nostringval--   false   1   %stopped_push   1905   1   3   %oparray_pop   1904   1   3   %oparray_pop   1888   1   3   %oparray_pop   1771   1   3   %oparray_pop   --nostringval--   %errorexec_pop   .runexec2   --nostringval--   --nostringval--   --nostringval--   2   %stopped_push   --nostringval--   1777   0   3   %oparray_pop   --nostringval--   --nostringval--
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Dictionary stack:
>D [27/Mar/2008:08:50:24 -0700] [Job 18] --dict:1169/1684(ro)(G)--   --dict:1/20(G)--   --dict:99/200(L)--
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Current allocation mode is local
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Last OS error: 32
>D [27/Mar/2008:08:50:24 -0700] [Job 18] GPL Ghostscript 8.62: Unrecoverable error, exit code 1
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Process 8900 ending: "foomatic-gswrapper -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -sDEVICE=ijs -sIjsServer=hpijs -sDev..."
>D [27/Mar/2008:08:50:24 -0700] [Job 18] renderer return value: 1
>D [27/Mar/2008:08:50:24 -0700] [Job 18] renderer received signal: 1
>D [27/Mar/2008:08:50:24 -0700] [Job 18] KID3 exited with status 3
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Renderer exit stat: 3
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Process dying with "Possible error on renderer command line or PostScript error. Check options.", exit stat: 3
>D [27/Mar/2008:08:50:24 -0700] [Job 18] error: Illegal seek (29)
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Cleaning up ...
>D [27/Mar/2008:08:50:24 -0700] [Job 18] Killing process 8899 (KID4) with signal 15
>D [27/Mar/2008:08:50:29 -0700] [Job 18] Killing process 8899 (KID4) with signal 9
>D [27/Mar/2008:08:50:29 -0700] [Job 18]
>D [27/Mar/2008:08:50:29 -0700] [Job 18] Closing foomatic-rip.
>D [27/Mar/2008:08:50:29 -0700] [Job 18] Renderer process finished
>D [27/Mar/2008:08:50:29 -0700] [Job 18] Process dying with "Error closing renderer", exit stat: 3
>D [27/Mar/2008:08:50:29 -0700] [Job 18] error: Bad file descriptor (9)
>D [27/Mar/2008:08:50:29 -0700] [Job 18] Cleaning up ...
>D [27/Mar/2008:08:50:29 -0700] [Job 18] Killing process 8898 (KID3) with signal 15
>D [27/Mar/2008:08:50:34 -0700] [Job 18] Killing process 8898 (KID3) with signal 9
>D [27/Mar/2008:08:50:34 -0700] [Job 18] Error closing renderer
>D [27/Mar/2008:08:50:34 -0700] [Job 18]
>D [27/Mar/2008:08:50:34 -0700] [Job 18] Closing foomatic-rip.
>E [27/Mar/2008:08:50:34 -0700] PID 8893 (/usr/lib/cups/filter/foomatic-rip) stopped with status 3!
>D [27/Mar/2008:08:50:34 -0700] [Job 18] File 0 is complete.
>E [27/Mar/2008:08:50:34 -0700] [Job 18] Job stopped due to filter errors.
>I [27/Mar/2008:08:50:34 -0700] Saving subscriptions.conf...
>I [27/Mar/2008:08:50:34 -0700] Saving subscriptions.conf...
>D [27/Mar/2008:08:50:34 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:34 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:34 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:34 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:34 -0700] Get-Notifications /
>D [27/Mar/2008:08:50:34 -0700] cupsdIsAuthorized: requesting-user-name="darwinhwebb"
>D [27/Mar/2008:08:50:34 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:34 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:34 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:34 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:34 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:34 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:34 -0700] Get-Notifications /
>D [27/Mar/2008:08:50:34 -0700] cupsdIsAuthorized: requesting-user-name="darwinhwebb"
>D [27/Mar/2008:08:50:34 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:34 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:35 -0700] [Job 18] Unloading...
>D [27/Mar/2008:08:50:58 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:58 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:58 -0700] Report: clients=2
>D [27/Mar/2008:08:50:58 -0700] Report: jobs=10
>D [27/Mar/2008:08:50:58 -0700] Report: jobs-active=2
>D [27/Mar/2008:08:50:58 -0700] Report: printers=1
>D [27/Mar/2008:08:50:58 -0700] Report: printers-implicit=0
>D [27/Mar/2008:08:50:58 -0700] Report: stringpool-string-count=869
>D [27/Mar/2008:08:50:58 -0700] Report: stringpool-alloc-bytes=9048
>D [27/Mar/2008:08:50:58 -0700] Report: stringpool-total-bytes=18448
>D [27/Mar/2008:08:50:58 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:58 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:58 -0700] Get-Job-Attributes ipp://localhost/jobs/18
>D [27/Mar/2008:08:50:58 -0700] [Job 18] Loading attributes...
>D [27/Mar/2008:08:50:58 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:58 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:58 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:58 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:58 -0700] cupsdReadClient: 13 POST / HTTP/1.1
>D [27/Mar/2008:08:50:58 -0700] cupsdAuthorize: No authentication data provided.
>D [27/Mar/2008:08:50:58 -0700] Cancel-Subscription /
>D [27/Mar/2008:08:50:58 -0700] cupsdIsAuthorized: requesting-user-name="darwinhwebb"
>I [27/Mar/2008:08:50:58 -0700] Saving subscriptions.conf...
>D [27/Mar/2008:08:50:58 -0700] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
>D [27/Mar/2008:08:50:58 -0700] cupsdCloseClient: 13
>D [27/Mar/2008:08:50:58 -0700] cupsdAcceptClient: skipping getpeercon()
>D [27/Mar/2008:08:50:58 -0700] cupsdAcceptClient: 13 from localhost (Domain)
>D [27/Mar/2008:08:50:58 -0700] cupsdReadClient: 13 GET /admin/log/error_log HTTP/1.1
>D [27/Mar/2008:08:50:58 -0700] cupsdAuthorize: No authentication data provided.

Actions: View

Attachments on bug 439154: 299305 | 299306 | 299350 | 299351 | 305883 | 305897 | 305908 | 306169 | 306228 | 306253 | 306257 | 306264 | 306265