vice@defgw ~ $ lp test.txt 
request id is Brother_MFC-845CW_USB_1-12 (1 file(s))

==> /var/log/cups/access_log <==
localhost - - [24/Feb/2007:16:53:10 -0700] "POST / HTTP/1.1" 200 351 CUPS-Get-Printers successful-ok
localhost - - [24/Feb/2007:16:53:10 -0700] "POST / HTTP/1.1" 200 351 CUPS-Get-Classes successful-ok
localhost - - [24/Feb/2007:16:53:10 -0700] "POST / HTTP/1.1" 200 75 CUPS-Get-Default successful-ok
localhost - - [24/Feb/2007:16:53:10 -0700] "POST /printers/Brother_MFC-845CW_USB_1 HTTP/1.1" 200 268 Print-Job successful-ok

==> /var/log/cups/error_log <==
D [24/Feb/2007:16:53:10 -0700] cupsdAcceptClient: 7 from localhost (Domain)
D [24/Feb/2007:16:53:10 -0700] cupsdReadClient: 7 POST / HTTP/1.1
D [24/Feb/2007:16:53:10 -0700] cupsdAuthorize: No authentication data provided.
D [24/Feb/2007:16:53:10 -0700] CUPS-Get-Printers
D [24/Feb/2007:16:53:10 -0700] cupsdProcessIPPRequest: 7 status_code=0 (successful-ok)
D [24/Feb/2007:16:53:10 -0700] cupsdReadClient: 7 POST / HTTP/1.1
D [24/Feb/2007:16:53:10 -0700] cupsdAuthorize: No authentication data provided.
D [24/Feb/2007:16:53:10 -0700] CUPS-Get-Classes
D [24/Feb/2007:16:53:10 -0700] cupsdProcessIPPRequest: 7 status_code=0 (successful-ok)
D [24/Feb/2007:16:53:10 -0700] cupsdReadClient: 7 POST / HTTP/1.1
D [24/Feb/2007:16:53:10 -0700] cupsdAuthorize: No authentication data provided.
D [24/Feb/2007:16:53:10 -0700] CUPS-Get-Default
D [24/Feb/2007:16:53:10 -0700] cupsdProcessIPPRequest: 7 status_code=0 (successful-ok)
D [24/Feb/2007:16:53:10 -0700] cupsdCloseClient: 7
D [24/Feb/2007:16:53:10 -0700] cupsdAcceptClient: 7 from localhost (Domain)
D [24/Feb/2007:16:53:10 -0700] cupsdReadClient: 7 POST /printers/Brother_MFC-845CW_USB_1 HTTP/1.1
D [24/Feb/2007:16:53:10 -0700] cupsdAuthorize: No authentication data provided.
D [24/Feb/2007:16:53:10 -0700] Print-Job ipp://localhost/printers/Brother_MFC-845CW_USB_1
D [24/Feb/2007:16:53:10 -0700] print_job: auto-typing file...
D [24/Feb/2007:16:53:10 -0700] print_job: request file type is text/plain.
D [24/Feb/2007:16:53:10 -0700] add_job: requesting-user-name="vice"
I [24/Feb/2007:16:53:10 -0700] Adding start banner page "none" to job 13.
D [24/Feb/2007:16:53:10 -0700] Discarding unused job-created event...
I [24/Feb/2007:16:53:10 -0700] Adding end banner page "none" to job 13.
I [24/Feb/2007:16:53:10 -0700] Job 13 queued on "Brother_MFC-845CW_USB_1" by "vice".
D [24/Feb/2007:16:53:10 -0700] Job 13 hold_until = 0
D [24/Feb/2007:16:53:10 -0700] Discarding unused printer-state-changed event...
D [24/Feb/2007:16:53:10 -0700] job-sheets=none,none
D [24/Feb/2007:16:53:10 -0700] banner_page = 0
D [24/Feb/2007:16:53:10 -0700] [Job 13] argv[0]="Brother_MFC-845CW_USB_1"
D [24/Feb/2007:16:53:10 -0700] [Job 13] argv[1]="13"
D [24/Feb/2007:16:53:10 -0700] [Job 13] argv[2]="vice"
D [24/Feb/2007:16:53:10 -0700] [Job 13] argv[3]="test.txt"
D [24/Feb/2007:16:53:10 -0700] [Job 13] argv[4]="1"
D [24/Feb/2007:16:53:10 -0700] [Job 13] argv[5]="job-uuid=urn:uuid:368a7891-28fb-364f-76bc-1785b40ad6ba"
D [24/Feb/2007:16:53:10 -0700] [Job 13] argv[6]="/var/spool/cups/d00013-001"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[2]="CUPS_DOCROOT=/usr/share/cups/html"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[5]="CUPS_SERVERBIN=/usr/libexec/cups"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[8]="PATH=/usr/libexec/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[9]="SERVER_ADMIN=root@defgw"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[10]="SOFTWARE=CUPS/1.2.8"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[12]="USER=root"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[13]="CUPS_SERVER=/var/run/cups/cups.sock"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[14]="CUPS_ENCRYPTION=IfRequested"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[15]="IPP_PORT=631"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[16]="CHARSET=utf-8"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[17]="LANG=en_US"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[18]="PPD=/etc/cups/ppd/Brother_MFC-845CW_USB_1.ppd"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[19]="RIP_MAX_CACHE=8m"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[20]="CONTENT_TYPE=text/plain"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[21]="DEVICE_URI=usb://Brother/MFC-845CW"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[22]="PRINTER=Brother_MFC-845CW_USB_1"
D [24/Feb/2007:16:53:10 -0700] [Job 13] envp[23]="FINAL_CONTENT_TYPE=printer/Brother_MFC-845CW_USB_1"
I [24/Feb/2007:16:53:10 -0700] Started filter /usr/libexec/cups/filter/texttops (PID 23709) for job 13.
I [24/Feb/2007:16:53:10 -0700] Started filter /usr/libexec/cups/filter/pstops (PID 23710) for job 13.
I [24/Feb/2007:16:53:10 -0700] Started filter /usr/libexec/cups/filter/brlpdwrappermfc845cw (PID 23711) for job 13.
I [24/Feb/2007:16:53:10 -0700] Started backend /usr/libexec/cups/backend/usb (PID 23715) for job 13.
D [24/Feb/2007:16:53:10 -0700] Discarding unused job-state event...
D [24/Feb/2007:16:53:10 -0700] cupsdProcessIPPRequest: 7 status_code=0 (successful-ok)
D [24/Feb/2007:16:53:10 -0700] [Job 13] Page = 595x842; 9,9 to 586,833
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->num_fonts = 66
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[0] = AvantGarde-Book
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[1] = AvantGarde-BookOblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[2] = AvantGarde-Demi
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[3] = AvantGarde-DemiOblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[4] = Bookman-Demi
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[5] = Bookman-DemiItalic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[6] = Bookman-Light
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[7] = Bookman-LightItalic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[8] = Courier
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[9] = Courier-Bold
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->num_fonts = 66
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[0] = AvantGarde-Book
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[1] = AvantGarde-BookOblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[2] = AvantGarde-Demi
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[3] = AvantGarde-DemiOblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[4] = Bookman-Demi
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[5] = Bookman-DemiItalic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[6] = Bookman-Light
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[7] = Bookman-LightItalic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[8] = Courier
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->num_fonts = 66
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[0] = AvantGarde-Book
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[1] = AvantGarde-BookOblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[2] = AvantGarde-Demi
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[3] = AvantGarde-DemiOblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[4] = Bookman-Demi
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[5] = Bookman-DemiItalic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[6] = Bookman-Light
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[7] = Bookman-LightItalic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[8] = Courier
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[9] = Courier-Bold
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[10] = Courier-BoldOblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[11] = Courier-Oblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[12] = Helvetica
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[13] = Helvetica-Bold
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[14] = Helvetica-BoldOblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[15] = Helvetica-Narrow
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[16] = Helvetica-Narrow-Bold
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[17] = Helvetica-Narrow-BoldOblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[18] = Helvetica-Narrow-Oblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[19] = Helvetica-Oblique
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[20] = NewCenturySchlbk-Bold
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[21] = NewCenturySchlbk-BoldItalic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[22] = NewCenturySchlbk-Italic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[23] = NewCenturySchlbk-Roman
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[24] = Palatino-Bold
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[25] = Palatino-BoldItalic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[26] = Palatino-Italic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[27] = Palatino-Roman
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[28] = Times-Bold
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[29] = Times-BoldItalic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[30] = Times-Italic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[31] = Times-Roman
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[32] = ZapfChancery-MediumItalic
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[33] = ZapfDingbats
D [24/Feb/2007:16:53:10 -0700] [Job 13] ppd->fonts[34] = Symbol
D [24/Feb/2007:16:53:10 -0700] Discarding unused printer-state-changed event...
D [24/Feb/2007:16:53:10 -0700] [Job 13] Printer using device file "/dev/usb/lp0"...
D [24/Feb/2007:16:53:10 -0700] Discarding unused printer-state-changed event...
D [24/Feb/2007:16:53:10 -0700] [Job 13] backendRunLoop(print_fd=0, device_fd=4, use_bc=1)
D [24/Feb/2007:16:53:10 -0700] [Job 13] Page = 595x842; 9,9 to 586,833
D [24/Feb/2007:16:53:10 -0700] [Job 13] slow_collate=0, slow_duplex=0, slow_order=1
D [24/Feb/2007:16:53:10 -0700] [Job 13] Before copy_comments - %!PS-Adobe-3.0
D [24/Feb/2007:16:53:10 -0700] [Job 13] %!PS-Adobe-3.0
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%BoundingBox: 0 0 595 842
D [24/Feb/2007:16:53:10 -0700] [Job 13] %cupsRotation: 0
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%Creator: texttops/CUPS v1.2.8
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%CreationDate: Sat 24 Feb 2007 04:53:10 PM MST
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%Title: (test.txt)
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%For: (vice)
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%Pages: (atend)
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%DocumentNeededResources: font Courier-Bold
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%+ font Courier
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%+ font Symbol
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%DocumentSuppliedResources: procset texttops 1.1 0
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%+ font Courier-Bold
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%+ font Courier
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%+ font Symbol
D [24/Feb/2007:16:53:10 -0700] [Job 13] %%EndComments
D [24/Feb/2007:16:53:10 -0700] [Job 13] Before copy_prolog - %%BeginProlog
D [24/Feb/2007:16:53:10 -0700] cupsdCloseClient: 7
D [24/Feb/2007:16:53:10 -0700] PID 23709 (/usr/libexec/cups/filter/texttops) exited with no errors.
D [24/Feb/2007:16:53:10 -0700] [Job 13] Before copy_setup - %%Page: 1 1
D [24/Feb/2007:16:53:10 -0700] [Job 13] Before page loop - %%Page: 1 1
D [24/Feb/2007:16:53:10 -0700] [Job 13] Copying page 1...
D [24/Feb/2007:16:53:10 -0700] [Job 13] pagew = 577.0, pagel = 824.0
D [24/Feb/2007:16:53:10 -0700] [Job 13] bboxw = 595, bboxl = 842
D [24/Feb/2007:16:53:10 -0700] [Job 13] PageLeft = 9.0, PageRight = 586.0
D [24/Feb/2007:16:53:10 -0700] [Job 13] PageTop = 833.0, PageBottom = 9.0
D [24/Feb/2007:16:53:10 -0700] [Job 13] PageWidth = 595.0, PageLength = 842.0
D [24/Feb/2007:16:53:10 -0700] [Job 13] Wrote 1 pages...
D [24/Feb/2007:16:53:10 -0700] PID 23710 (/usr/libexec/cups/filter/pstops) exited with no errors.
D [24/Feb/2007:16:53:10 -0700] [Job 13] Error: error occurred at print phase !!
E [24/Feb/2007:16:53:10 -0700] [Job 13] No pages found!
D [24/Feb/2007:16:53:10 -0700] Discarding unused printer-state-changed event...
D [24/Feb/2007:16:53:10 -0700] [Job 13] ESP Ghostscript 815.03: Unrecoverable error, exit code 1
D [24/Feb/2007:16:53:10 -0700] PID 23711 (/usr/libexec/cups/filter/brlpdwrappermfc845cw) exited with no errors.
D [24/Feb/2007:16:53:10 -0700] PID 23715 (/usr/libexec/cups/backend/usb) exited with no errors.
D [24/Feb/2007:16:53:10 -0700] [Job 13] File 0 is complete.
D [24/Feb/2007:16:53:10 -0700] Discarding unused printer-state-changed event...
D [24/Feb/2007:16:53:10 -0700] Discarding unused job-completed event...
D [24/Feb/2007:16:53:11 -0700] Unloading job 13...