Empty Print File error for non-mac machine

chandrashekar chandu.ise at gmail.com
Wed Dec 14 02:06:44 PST 2011


Hi,

I am able to fix Empty Print File error, but still facing issues in other component this time getting connection error: Permission denied during Connecting printer....
Please let me know the solution for the above problem, pasting logs below

] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/Generic-PostScript) from localhost
D [03/Jan/2000:09:22:26 +0530] cupsdSetBusyState: Dirty files
D [03/Jan/2000:09:22:26 +0530] cupsdReadClient: 11 POST /printers/Generic-PostScript HTTP/1.1
D [03/Jan/2000:09:22:26 +0530] cupsdSetBusyState: Active clients and dirty files
D [03/Jan/2000:09:22:26 +0530] cupsdAuthorize: No authentication data provided.
D [03/Jan/2000:09:22:26 +0530] cupsdReadClient: 11 1.1 Send-Document 1
D [03/Jan/2000:09:22:26 +0530] Send-Document ipp://localhost:631/printers/Generic-PostScript
D [03/Jan/2000:09:22:26 +0530] cupsdIsAuthorized: requesting-user-name="root"
D [03/Jan/2000:09:22:26 +0530] [Job 1] Auto-typing file...
D [03/Jan/2000:09:22:26 +0530] [Job 1] Request file type is text/plain.
D [03/Jan/2000:09:22:26 +0530] cupsdMarkDirty(----J-)
I [03/Jan/2000:09:22:26 +0530] [Job 1] File of type text/plain queued by "root".
I [03/Jan/2000:09:22:26 +0530] [Job 1] Adding end banner page "none".
D [03/Jan/2000:09:22:26 +0530] cupsdMarkDirty(----J-)
D [03/Jan/2000:09:22:26 +0530] cupsdMarkDirty(----J-)
D [03/Jan/2000:09:22:26 +0530] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Jan/2000:09:22:26 +0530] Discarding unused printer-state-changed event...
D [03/Jan/2000:09:22:26 +0530] [Job 1] job-sheets=none,none
D [03/Jan/2000:09:22:26 +0530] [Job 1] argv[0]="Generic-PostScript"
D [03/Jan/2000:09:22:26 +0530] [Job 1] argv[1]="1"
D [03/Jan/2000:09:22:26 +0530] [Job 1] argv[2]="root"
D [03/Jan/2000:09:22:26 +0530] [Job 1] argv[3]="File.txt"
D [03/Jan/2000:09:22:26 +0530] [Job 1] argv[4]="1"
D [03/Jan/2000:09:22:26 +0530] [Job 1] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:47dc9639-da07-3020-5ffa-e5f315399cbf job-originating-host-name=localhost time-at-creation=946871546 time-at-processing=946871546 AP_D_InputSlot="
D [03/Jan/2000:09:22:26 +0530] [Job 1] argv[6]="/system/cups_shared/var/spool/cups/d00001-001"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[0]="CUPS_CACHEDIR=/system/cups_shared/var/cache/cups"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[1]="CUPS_DATADIR=/system/cups_shared/share/cups"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[2]="CUPS_DOCROOT=/system/cups_shared/share/doc/cups"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[3]="CUPS_FONTPATH=/system/cups_shared/share/cups/fonts"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[4]="CUPS_REQUESTROOT=/system/cups_shared/var/spool/cups"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[5]="CUPS_SERVERBIN=/system/cups_shared/lib/cups"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[6]="CUPS_SERVERROOT=/system/cups_shared/etc/cups"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[7]="CUPS_STATEDIR=/system/cups_shared/var/run/cups"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[8]="HOME=/system/cups_shared/var/spool/cups/tmp"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[9]="LD_LIBRARY_PATH=/vendor/lib:/system/lib"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[10]="PATH=/system/cups_shared/lib/cups/filter:/system/cups_shared/bin:/system/cups_shared/sbin:/bin:/usr/bin"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[11]="SERVER_ADMIN=root at localhost"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[12]="SOFTWARE=CUPS/1.4.6"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[13]="TMPDIR=/system/cups_shared/var/spool/cups/tmp"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[14]="USER=root"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[15]="CUPS_SERVER=/system/cups_shared/var/run/cups/cups.sock"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[17]="IPP_PORT=631"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[18]="CHARSET=utf-8"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[19]="LANG=en_US.UTF-8"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[20]="PPD=/system/cups_shared/etc/cups/ppd/Generic-PostScript.ppd"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[21]="RIP_MAX_CACHE=8m"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[22]="CONTENT_TYPE=text/plain"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[23]="DEVICE_URI=ipp://107.108.210.93:631/PASSTHRU"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[24]="PRINTER_INFO=Generic-PostScript"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[25]="PRINTER_LOCATION="
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[26]="PRINTER=Generic-PostScript"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[27]="CUPS_FILETYPE=document"
D [03/Jan/2000:09:22:26 +0530] [Job 1] envp[28]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [03/Jan/2000:09:22:26 +0530] [Job 1] Started filter /system/cups_shared/lib/cups/filter/texttops (PID 6485)
D [03/Jan/2000:09:22:26 +0530] [Job 1] Started filter /system/cups_shared/lib/cups/filter/pstops (PID 6486)
I [03/Jan/2000:09:22:26 +0530] [Job 1] Started backend /system/cups_shared/lib/cups/backend/ipp (PID 6487)
D [03/Jan/2000:09:22:26 +0530] Discarding unused job-state-changed event...
D [03/Jan/2000:09:22:26 +0530] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/Generic-PostScript) from localhost
D [03/Jan/2000:09:22:26 +0530] cupsdSetBusyState: Printing jobs and dirty files
D [03/Jan/2000:09:22:26 +0530] cupsdReadClient: 11 WAITING Closing on EOF
D [03/Jan/2000:09:22:26 +0530] cupsdCloseClient: 11
D [03/Jan/2000:09:22:26 +0530] [Job 1] STATE: +connecting-to-device
D [03/Jan/2000:09:22:26 +0530] Discarding unused printer-state-changed event...
D [03/Jan/2000:09:22:26 +0530] [Job 1] Looking up "107.108.210.93"...
I [03/Jan/2000:09:22:26 +0530] [Job 1] Copying print data...
D [03/Jan/2000:09:22:26 +0530] Discarding unused job-progress event...
D [03/Jan/2000:09:22:26 +0530] Discarding unused printer-state-changed event...
D [03/Jan/2000:09:22:26 +0530] [Job 1] backendRunLoop(print_fd=-1, device_fd=5, snmp_fd=-1, addr=0x14044, use_bc=0, side_cb=0xb4fd)
D [03/Jan/2000:09:22:26 +0530] [Job 1] Page = 595x842; 18,36 to 577,806
D [03/Jan/2000:09:22:26 +0530] [Job 1] ppd->num_fonts = 70
D [03/Jan/2000:09:22:26 +0530] [Job 1] ppd->fonts[0] = AvantGarde-Book
D [03/Jan/2000:09:22:26 +0530] [Job 1] ppd->fonts[1] = AvantGarde-BookOblique
D [03/Jan/2000:09:22:26 +0530] [Job 1] ppd->fonts[2] = AvantGarde-Demi
D [03/Jan/2000:09:22:26 +0530] [Job 1] ppd->fonts[3] = AvantGarde-DemiOblique
D [03/Jan/2000:09:22:26 +0530] [Job 1] ppd->fonts[4] = Bookman-Demi
D [03/Jan/2000:09:22:26 +0530] [Job 1] ppd->fonts[5] = Bookman-DemiItalic
D [03/Jan/2000:09:22:26 +0530] [Job 1] ppd->fonts[6] = Bookman-Light
D [03/Jan/2000:09:22:26 +0530] [Job 1] ppd->fonts[7] = Bookman-LightItalic
D [03/Jan/2000:09:22:26 +0530] [Job 1] slow_collate=0, slow_duplex=0, slow_order=0
D [03/Jan/2000:09:22:26 +0530] [Job 1] Before copy_comments - %!PS-Adobe-3.0
D [03/Jan/2000:09:22:26 +0530] [Job 1] %!PS-Adobe-3.0
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%BoundingBox: 0 0 595 842
D [03/Jan/2000:09:22:26 +0530] [Job 1] %cupsRotation: 0
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%Creator: texttops/CUPS v1.4.6
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%CreationDate: Mon Jan  3 03:52:26 2000
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%Title: (File.txt)
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%For: (root)
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%Pages: (atend)
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%DocumentNeededResources: font Monospace-Bold
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%+ font Monospace
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%DocumentSuppliedResources: procset texttops 1.1 0
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%+ font Monospace-Bold
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%+ font Monospace
D [03/Jan/2000:09:22:26 +0530] [Job 1] %%EndComments
D [03/Jan/2000:09:22:26 +0530] [Job 1] Before copy_prolog - %%BeginProlog
D [03/Jan/2000:09:22:26 +0530] PID 6485 (/system/cups_shared/lib/cups/filter/texttops) exited with no errors.
D [03/Jan/2000:09:22:26 +0530] [Job 1] Read 1372 bytes of print data...
D [03/Jan/2000:09:22:26 +0530] [Job 1] Wrote 1372 bytes of print data...
D [03/Jan/2000:09:22:26 +0530] [Job 1] Wrote 1 pages...
D [03/Jan/2000:09:22:26 +0530] [Job 1] Read 55 bytes of print data...
D [03/Jan/2000:09:22:26 +0530] [Job 1] Wrote 55 bytes of print data...
D [03/Jan/2000:09:22:26 +0530] [Job 1] 1 files to send in job...
D [03/Jan/2000:09:22:26 +0530] [Job 1] STATE: +connecting-to-device
D [03/Jan/2000:09:22:26 +0530] [Job 1] Connecting to 107.108.210.93:631
I [03/Jan/2000:09:22:26 +0530] [Job 1] Connecting to printer...
D [03/Jan/2000:09:22:26 +0530] [Job 1] Connection error: Permission denied
D [03/Jan/2000:09:22:26 +0530] cupsdMarkDirty(P-----)
D [03/Jan/2000:09:22:26 +0530] Discarding unused job-progress event...
D [03/Jan/2000:09:22:26 +0530] Discarding unused printer-state-changed event...
D [03/Jan/2000:09:22:26 +0530] PID 6486 (/system/cups_shared/lib/cups/filter/pstops) exited with no errors.
D [03/Jan/2000:09:22:56 +0530] [Job 1] Connecting to 107.108.210.93:631
I [03/Jan/2000:09:22:56 +0530] [Job 1] Connecting to printer...
D [03/Jan/2000:09:22:56 +0530] [Job 1] Connection error: Permission denied
I [03/Jan/2000:09:22:56 +0530] Saving printers.conf...
I [03/Jan/2000:09:22:56 +0530] Saving job cache file "/system/cups_shared/var/cache/cups/job.cache"...
D [03/Jan/2000:09:22:56 +0530] cupsdSetBusyState: Printing jobs
D [03/Jan/2000:09:22:56 +0530] Report: clients=0
D [03/Jan/2000:09:22:56 +0530] Report: jobs=1
D [03/Jan/2000:09:22:56 +0530] Report: jobs-active=1
D [03/Jan/2000:09:22:56 +0530] Report: printers=1
D [03/Jan/2000:09:22:56 +0530] Report: printers-implicit=0
D [03/Jan/2000:09:22:56 +0530] Report: stringpool-string-count=3796
D [03/Jan/2000:09:22:56 +0530] Report: stringpool-alloc-bytes=11232
D [03/Jan/2000:09:22:56 +0530] Report: stringpool-total-bytes=73520
D [03/Jan/2000:09:23:26 +0530] [Job 1] Connecting to 107.108.210.93:631
I [03/Jan/2000:09:23:26 +0530] [Job 1] Connecting to printer...
D [03/Jan/2000:09:23:26 +0530] [Job 1] Connection error: Permission denied
D [03/Jan/2000:09:23:56 +0530] [Job 1] Connecting to 107.108.210.93:631
I [03/Jan/2000:09:23:56 +0530] [Job 1] Connecting to printer...
D [03/Jan/2000:09:23:56 +0530] [Job 1] Connection error: Permission denied










> The spool directory cannot be read by the print filters.
>
>
> On Dec 13, 2011, at 4:02 AM, chandrashekar wrote:
>
> > Hi,
> >
> > I am getting Empty print file error. I am pasting entire log information. Can someone help me what has gone wrong. I am unable to figure it out from this log.
> >
> >
> >
> > E [02/Jan/2000:11:37:08 +0530] TMPDIR (/data/local/tmp) has the wrong permissions!
> > E [02/Jan/2000:12:07:04 +0530] TMPDIR (/system/cups_shared/var/spool/cups/tmp) has the wrong permissions!
> > E [02/Jan/2000:12:07:04 +0530] [Job 1] Empty print file!
> > E [02/Jan/2000:12:07:04 +0530] [Job 1] Empty print file!
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] The following messages were recorded from 12:07:04 to 12:07:04
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] job-sheets=none,none
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] argv[0]="Generic-PostScript"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] argv[1]="1"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] argv[2]="root"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] argv[3]="File.txt"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] argv[4]="1"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:47dc9639-da07-3020-5ffa-e5f315399cbf job-originating-host-name=localhost time-at-creation=946793376 time-at-processing=946795024 AP_D_InputSlot="
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] argv[6]="/system/cups_shared/var/spool/cups/d00001-001"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[0]="CUPS_CACHEDIR=/system/cups_shared/var/cache/cups"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[1]="CUPS_DATADIR=/system/cups_shared/share/cups"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[2]="CUPS_DOCROOT=/system/cups_shared/share/doc/cups"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[3]="CUPS_FONTPATH=/system/cups_shared/share/cups/fonts"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[4]="CUPS_REQUESTROOT=/system/cups_shared/var/spool/cups"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[5]="CUPS_SERVERBIN=/system/cups_shared/lib/cups"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[6]="CUPS_SERVERROOT=/system/cups_shared/etc/cups"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[7]="CUPS_STATEDIR=/system/cups_shared/var/run/cups"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[8]="HOME=/system/cups_shared/var/spool/cups/tmp"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[9]="LD_LIBRARY_PATH=/vendor/lib:/system/lib"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[10]="PATH=/system/cups_shared/lib/cups/filter:/system/cups_shared/bin:/system/cups_shared/sbin:/bin:/usr/bin"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[11]="SERVER_ADMIN=root at localhost"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[12]="SOFTWARE=CUPS/1.4.6"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[13]="TMPDIR=/system/cups_shared/var/spool/cups/tmp"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[14]="USER=root"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[15]="CUPS_SERVER=/system/cups_shared/var/run/cups/cups.sock"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[16]="CUPS_ENCRYPTION=IfRequested"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[17]="IPP_PORT=631"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[18]="CHARSET=utf-8"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[19]="LANG=en_US.UTF-8"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[20]="PPD=/system/cups_shared/etc/cups/ppd/Generic-PostScript.ppd"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[21]="RIP_MAX_CACHE=8m"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[22]="CONTENT_TYPE=text/plain"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[23]="DEVICE_URI=ipp://107.108.210.93:631/PASSTHRU"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[24]="PRINTER_INFO=Generic-PostScript"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[25]="PRINTER_LOCATION="
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[26]="PRINTER=Generic-PostScript"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[27]="CUPS_FILETYPE=document"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] envp[28]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] Started filter /system/cups_shared/lib/cups/filter/texttops (PID 5344)
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] Started filter /system/cups_shared/lib/cups/filter/pstops (PID 5345)
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] Started backend /system/cups_shared/lib/cups/backend/ipp (PID 5346)
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] unable to open print file - STATE: +connecting-to-device
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] Looking up "107.108.210.93"...
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] Copying print data...
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] backendRunLoop(print_fd=-1, device_fd=5, snmp_fd=-1, addr=0x14044, use_bc=0, side_cb=0xb4fd)
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] : Permission denied
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] Backend returned status 1 (failed)
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] Printer stopped due to backend errors; please consult the error_log file for details.
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] End of messages
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] printer-state=5(stopped)
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] printer-state-message="Empty print file!"
> > D [02/Jan/2000:12:07:04 +0530] [Job 1] printer-state-reasons=paused
> >
> > _______________________________________________
> > cups mailing list
> > cups at easysw.com
> > http://lists.easysw.com/mailman/listinfo/cups
>
> _________________________________________________________
> Michael Sweet, Senior Printing System Engineer, PWG Chair
>





More information about the cups mailing list