I don't know what to do next, I don't know why the printer does response and no error prompt out.
Code: Select all
d [10/Aug/2007:11:29:46 +0000] cupsdAuthorize: con->uri="/printers/Xerox_Phaser_3116_USB_1", con->best=0x809f678(/)
d [10/Aug/2007:11:29:46 +0000] cupsdAuthorize: Authorization=""
D [10/Aug/2007:11:29:46 +0000] cupsdAuthorize: No authentication data provided.
d [10/Aug/2007:11:29:46 +0000] cupsdIsAuthorized: con->uri="/printers/Xerox_Phaser_3116_USB_1", con->best=0x809f678(/)
d [10/Aug/2007:11:29:46 +0000] cupsdIsAuthorized: level=AUTH_ANON, type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [10/Aug/2007:11:29:46 +0000] cupsdIsAuthorized: auth=AUTH_ALLOW...
d [10/Aug/2007:11:29:46 +0000] POST /printers/Xerox_Phaser_3116_USB_1
d [10/Aug/2007:11:29:46 +0000] CONTENT_TYPE = application/ipp
d [10/Aug/2007:11:29:46 +0000] cupsdReadClient: 10 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=18679, con->file=-1
d [10/Aug/2007:11:29:46 +0000] cupsdReadClient: 10 REQUEST /var/spool/cups/00000001=12
d [10/Aug/2007:11:29:46 +0000] cupsdReadClient: 10 writing 18441 bytes to 12
d [10/Aug/2007:11:29:46 +0000] cupsdReadClient: 10 Closing data file 12, size=18441.
d [10/Aug/2007:11:29:46 +0000] cupsdProcessIPPRequest(0x80caa08[10]): operation_id = 0002
D [10/Aug/2007:11:29:46 +0000] Print-Job ipp://localhost:631/printers/Xerox_Phaser_3116_USB_1
d [10/Aug/2007:11:29:46 +0000] print_job(0x80caa08[10], ipp://localhost:631/printers/Xerox_Phaser_3116_USB_1)
D [10/Aug/2007:11:29:46 +0000] print_job: request file type is application/postscript.
d [10/Aug/2007:11:29:46 +0000] add_job(0x80caa08[10], ipp://localhost:631/printers/Xerox_Phaser_3116_USB_1)
d [10/Aug/2007:11:29:46 +0000] cupsdFindPolicyOp(p=0x80a3d78, op=2(Print-Job))
d [10/Aug/2007:11:29:46 +0000] cupsdFindPolicyOp: Found wildcard match...
d [10/Aug/2007:11:29:46 +0000] cupsdIsAuthorized: con->uri="/printers/Xerox_Phaser_3116_USB_1", con->best=0x80a4df0((null))
d [10/Aug/2007:11:29:46 +0000] cupsdIsAuthorized: level=AUTH_ANON, type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [10/Aug/2007:11:29:46 +0000] cupsdIsAuthorized: op=0(unknown-0000)
d [10/Aug/2007:11:29:46 +0000] cupsdIsAuthorized: auth=AUTH_ALLOW...
d [10/Aug/2007:11:29:46 +0000] check_quotas(0x80caa08[10], 0x809db58[Xerox_Phaser_3116_USB_1])
D [10/Aug/2007:11:29:46 +0000] add_job: requesting-user-name="guest"
D [10/Aug/2007:11:29:46 +0000] Adding default job-sheets values "none,none"...
I [10/Aug/2007:11:29:46 +0000] Adding start banner page "none" to job 25.
d [10/Aug/2007:11:29:46 +0000] copy_banner(0x80caa08[10], 0x80d2598[25], none)
d [10/Aug/2007:11:29:46 +0000] add_job_state_reasons(0x80caa08[10], 25)
d [10/Aug/2007:11:29:46 +0000] cupsdAddEvent(event=job-created, dest=0x809db58(Xerox_Phaser_3116_USB_1), job=0x80d2598(25), text="Job created.", ...)
D [10/Aug/2007:11:29:46 +0000] Discarding unused job-created event...
d [10/Aug/2007:11:29:46 +0000] add_file(con=0x80caa08[10], job=25, filetype=application/postscript, compression=0)
I [10/Aug/2007:11:29:46 +0000] Adding end banner page "none" to job 25.
d [10/Aug/2007:11:29:46 +0000] copy_banner(0x80caa08[10], 0x80d2598[25], none)
I [10/Aug/2007:11:29:46 +0000] Job 25 queued on "Xerox_Phaser_3116_USB_1" by "guest".
D [10/Aug/2007:11:29:46 +0000] Job 25 hold_until = 0
d [10/Aug/2007:11:29:46 +0000] cupsdSaveJob(job=0x80d2598(25)): job->attrs=0x80d20a0
d [10/Aug/2007:11:29:46 +0000] cupsdCheckJobs: 1 active jobs, sleeping=0, reload=0
d [10/Aug/2007:11:29:46 +0000] cupsdCheckJobs: Job 25: state_value=3, loaded=yes
d [10/Aug/2007:11:29:46 +0000] start_job: id = 25, file = 0/1
d [10/Aug/2007:11:29:46 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x809db58(Xerox_Phaser_3116_USB_1), job=(nil)(0), text="%s "%s" state changed.", ...)
D [10/Aug/2007:11:29:46 +0000] Discarding unused printer-state-changed event...
D [10/Aug/2007:11:29:46 +0000] job-sheets=none,none
D [10/Aug/2007:11:29:46 +0000] banner_page = 0
D [10/Aug/2007:11:29:46 +0000] [Job 25] argv[0]="Xerox_Phaser_3116_USB_1"
D [10/Aug/2007:11:29:46 +0000] [Job 25] argv[1]="25"
D [10/Aug/2007:11:29:46 +0000] [Job 25] argv[2]="guest"
D [10/Aug/2007:11:29:46 +0000] [Job 25] argv[3]="Test Page"
D [10/Aug/2007:11:29:46 +0000] [Job 25] argv[4]="1"
D [10/Aug/2007:11:29:46 +0000] [Job 25] argv[5]="job-uuid=urn:uuid:6198b9b9-0b44-3117-4487-01dd0f948234"
D [10/Aug/2007:11:29:46 +0000] [Job 25] argv[6]="/var/spool/cups/d00025-001"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[2]="CUPS_DOCROOT=/usr/share/cups/html"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[5]="CUPS_SERVERBIN=/usr/libexec/cups"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[8]="PATH=/usr/libexec/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[9]="SERVER_ADMIN=root@lexus"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[10]="SOFTWARE=CUPS/1.2.10"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[12]="USER=root"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[13]="CUPS_SERVER=/var/run/cups/cups.sock"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[14]="CUPS_ENCRYPTION=IfRequested"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[15]="IPP_PORT=631"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[16]="CHARSET=utf-8"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[17]="LANG=zh_TW"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[18]="PPD=/etc/cups/ppd/Xerox_Phaser_3116_USB_1.ppd"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[19]="RIP_MAX_CACHE=8m"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[20]="CONTENT_TYPE=application/postscript"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[21]="DEVICE_URI=usb://Xerox/Phaser%203116"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[22]="PRINTER=Xerox_Phaser_3116_USB_1"
D [10/Aug/2007:11:29:46 +0000] [Job 25] envp[23]="FINAL_CONTENT_TYPE=printer/Xerox_Phaser_3116_USB_1"
d [10/Aug/2007:11:29:46 +0000] start_job: status_pipes = [ 14 15 ]
d [10/Aug/2007:11:29:46 +0000] start_job: filter="/usr/libexec/cups/filter/pstops"
d [10/Aug/2007:11:29:46 +0000] start_job: filterfds[0]=[ 16 17 ]
d [10/Aug/2007:11:29:46 +0000] cupsdStartProcess("/usr/libexec/cups/filter/pstops", 0x80d3a18, 0xbff5527c, -1, 17, 15)
d [10/Aug/2007:11:29:46 +0000] start_job: Closing filter pipes for slot 1 [ -1 -1 ]...
I [10/Aug/2007:11:29:46 +0000] Started filter /usr/libexec/cups/filter/pstops (PID 4541) for job 25.
d [10/Aug/2007:11:29:46 +0000] start_job: print_pipes = [ 18 19 ]
d [10/Aug/2007:11:29:46 +0000] start_job: filter="/usr/libexec/cups/filter/ppmtospl2"
d [10/Aug/2007:11:29:46 +0000] start_job: filterfds[1]=[ 18 19 ]
d [10/Aug/2007:11:29:46 +0000] cupsdStartProcess("/usr/libexec/cups/filter/ppmtospl2", 0x80d3a18, 0xbff5527c, 16, 19, 15)
d [10/Aug/2007:11:29:46 +0000] start_job: Closing filter pipes for slot 0 [ 16 17 ]...
I [10/Aug/2007:11:29:46 +0000] Started filter /usr/libexec/cups/filter/ppmtospl2 (PID 4542) for job 25.
d [10/Aug/2007:11:29:46 +0000] start_job: backend="/usr/libexec/cups/backend/usb"
d [10/Aug/2007:11:29:46 +0000] start_job: filterfds[0] = [ -1 -1 ]
d [10/Aug/2007:11:29:46 +0000] cupsdStartProcess("/usr/libexec/cups/backend/usb", 0x80d3a18, 0xbff5527c, 18, -1, 15)
I [10/Aug/2007:11:29:46 +0000] Started backend /usr/libexec/cups/backend/usb (PID 4543) for job 25.
d [10/Aug/2007:11:29:46 +0000] start_job: Closing print pipes [ 18 19 ]...
d [10/Aug/2007:11:29:46 +0000] start_job: Closing back pipes [ 12 13 ]...
d [10/Aug/2007:11:29:46 +0000] start_job: Closing status output pipe 15...
d [10/Aug/2007:11:29:46 +0000] start_job: Closing filter pipes for slot 0 [ -1 -1 ]...
d [10/Aug/2007:11:29:46 +0000] start_job: Adding fd 14 to InputSet...
d [10/Aug/2007:11:29:46 +0000] cupsdAddEvent(event=job-state, dest=0x809db58(Xerox_Phaser_3116_USB_1), job=0x80d2598(25), text="Job #%d started.", ...)
D [10/Aug/2007:11:29:46 +0000] Discarding unused job-state event...
D [10/Aug/2007:11:29:46 +0000] cupsdProcessIPPRequest: 10 status_code=0 (successful-ok)
d [10/Aug/2007:11:29:46 +0000] cupsdProcessIPPRequest: Adding fd 10 to OutputSet...
d [10/Aug/2007:11:29:46 +0000] process_children()
D [10/Aug/2007:11:29:46 +0000] PID 4541 (/usr/libexec/cups/filter/pstops) exited with no errors.
D [10/Aug/2007:11:29:46 +0000] PID 4542 (/usr/libexec/cups/filter/ppmtospl2) exited with no errors.
D [10/Aug/2007:11:29:46 +0000] [Job 25] Page = 595x842; 12,12 to 582,830
D [10/Aug/2007:11:29:46 +0000] [Job 25] slow_collate=0, slow_duplex=0, slow_order=0
D [10/Aug/2007:11:29:46 +0000] [Job 25] Before copy_comments - %!PS-Adobe-3.0
D [10/Aug/2007:11:29:46 +0000] [Job 25] %!PS-Adobe-3.0
D [10/Aug/2007:11:29:46 +0000] [Job 25] %%BoundingBox: 0 0 612 792
D [10/Aug/2007:11:29:46 +0000] [Job 25] %%Pages: 1
D [10/Aug/2007:11:29:46 +0000] [Job 25] %%LanguageLevel: 1
D [10/Aug/2007:11:29:46 +0000] [Job 25] %%DocumentData: Clean7Bit
D [10/Aug/2007:11:29:46 +0000] [Job 25] %%DocumentSuppliedResources: procset testprint/1.2
D [10/Aug/2007:11:29:46 +0000] [Job 25] %%DocumentNeededResources: font Helvetica Helvetica-Bold Times-Roman
D [10/Aug/2007:11:29:46 +0000] [Job 25] %%Creator: Michael Sweet, Easy Software Products
D [10/Aug/2007:11:29:46 +0000] [Job 25] %%CreationDate: D:20070220113000+0500
D [10/Aug/2007:11:29:46 +0000] [Job 25] %%Title: Test Page
D [10/Aug/2007:11:29:46 +0000] [Job 25] %%EndComments
D [10/Aug/2007:11:29:46 +0000] [Job 25] Before copy_prolog - %%BeginProlog
D [10/Aug/2007:11:29:46 +0000] [Job 25] Before copy_setup - %%Page: 1 1
D [10/Aug/2007:11:29:46 +0000] [Job 25] Before page loop - %%Page: 1 1
D [10/Aug/2007:11:29:46 +0000] [Job 25] Copying page 1...
D [10/Aug/2007:11:29:46 +0000] [Job 25] pagew = 570.0, pagel = 817.0
D [10/Aug/2007:11:29:46 +0000] [Job 25] bboxw = 595, bboxl = 842
D [10/Aug/2007:11:29:46 +0000] [Job 25] PageLeft = 12.5, PageRight = 582.5
D [10/Aug/2007:11:29:46 +0000] [Job 25] PageTop = 829.5, PageBottom = 12.5
D [10/Aug/2007:11:29:46 +0000] [Job 25] PageWidth = 595.0, PageLength = 842.0
D [10/Aug/2007:11:29:46 +0000] [Job 25] Wrote 1 pages...
D [10/Aug/2007:11:29:46 +0000] [Job 25] Failed to parse XML file: /etc/linuxprint.cfg
d [10/Aug/2007:11:29:46 +0000] [Job 25] STATE: +connecting-to-device
d [10/Aug/2007:11:29:46 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x809db58(Xerox_Phaser_3116_USB_1), job=(nil)(0), text="Printer "%s" state changed.", ...)
D [10/Aug/2007:11:29:46 +0000] Discarding unused printer-state-changed event...
d [10/Aug/2007:11:29:46 +0000] cupsdWriteClient: 10 bytes < 0
d [10/Aug/2007:11:29:46 +0000] cupsdWriteClient: Removing fd 10 from OutputSet...
D [10/Aug/2007:11:29:46 +0000] [Job 25] Printer using device file "/dev/usb/lp0"...
d [10/Aug/2007:11:29:46 +0000] [Job 25] STATE: -connecting-to-device
D [10/Aug/2007:11:29:46 +0000] [Job 25] backendRunLoop(print_fd=0, device_fd=4, use_bc=1)
d [10/Aug/2007:11:29:46 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x809db58(Xerox_Phaser_3116_USB_1), job=(nil)(0), text="Printer "%s" state changed.", ...)
D [10/Aug/2007:11:29:46 +0000] Discarding unused printer-state-changed event...
As what I see in the log file, there is no error reported and the process should be complete.
I really don't know what to do next.... Can anyone help?[/code]