Login or Register to Ask a Question and Join Our Community


Linux

Very strange CUPS problem

Login to Discuss or Reply to this Discussion in Our Community

 
Thread Tools Search this Thread
Operating Systems Linux Very strange CUPS problem
# 1  
Old 08-20-2010
Very strange CUPS problem
I have a networked printer at IP 192.168.0.250 that I am trying to print to from my Fedora host at 192.168.0.210. It appears that the jobs are succeeding from the CUPS side, but nothing is being printed on the printer. Printer is brand new (I got a new one yesterday after I was seeing similar problems on my old USB one), and has paper, ink, etc.

I put log level on CUPS to "debug" and so it is rather long. But here is the pertinent section:
Quote:
D [20/Aug/2010:10:21:31 -0600] [Job 8] Before copy_prolog - %%BeginProlog
D [20/Aug/2010:10:21:31 -0600] [Job 8] Resolution: 600
D [20/Aug/2010:10:21:31 -0600] [Job 8] Page size: Letter
D [20/Aug/2010:10:21:31 -0600] [Job 8] Width: 612, height: 792
D [20/Aug/2010:10:21:31 -0600] [Job 8] Absolute margins: 12, 12, 600, 780
D [20/Aug/2010:10:21:31 -0600] [Job 8] Relative margins: 12, 12, 12, 12
D [20/Aug/2010:10:21:31 -0600] [Job 8] Resolved as "socket://192.168.0.250:9100"...
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -connecting-to-device
D [20/Aug/2010:10:21:31 -0600] [Job 8] Executing backend "/usr/lib/cups/backend/socket"...
D [20/Aug/2010:10:21:31 -0600] Discarding unused printer-state-changed event...
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: +connecting-to-device
D [20/Aug/2010:10:21:31 -0600] Discarding unused printer-state-changed event...
D [20/Aug/2010:10:21:31 -0600] [Job 8] Looking up "192.168.0.250"...
D [20/Aug/2010:10:21:31 -0600] [Job 8] Connecting to 192.168.0.250:9100
I [20/Aug/2010:10:21:31 -0600] [Job 8] Connecting to printer...
D [20/Aug/2010:10:21:31 -0600] Discarding unused job-progress event...
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -connecting-to-device
D [20/Aug/2010:10:21:31 -0600] Discarding unused printer-state-changed event...
I [20/Aug/2010:10:21:31 -0600] [Job 8] Connected to printer...
D [20/Aug/2010:10:21:31 -0600] [Job 8] Connected to 192.168.0.250:9100 (IPv4)...
D [20/Aug/2010:10:21:31 -0600] Discarding unused job-progress event...
D [20/Aug/2010:10:21:31 -0600] [Job 8] InputSlot: Default
D [20/Aug/2010:10:21:31 -0600] [Job 8] Value for MediaPosition: 0
D [20/Aug/2010:10:21:31 -0600] [Job 8] ColorModel: RGB
D [20/Aug/2010:10:21:31 -0600] [Job 8] Value for BitsPerPixel: 24
D [20/Aug/2010:10:21:31 -0600] [Job 8] Duplex: None
D [20/Aug/2010:10:21:31 -0600] [Job 8] Value for Duplex: false; Value for Tumble:
D [20/Aug/2010:10:21:31 -0600] [Job 8] PPD options: -r600 -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -dMediaPosition=0 -dBitsPerPixel=24 -dDuplex=false
D [20/Aug/2010:10:21:31 -0600] [Job 8] PostScript code from options: <</.HWMargins[12 12 12 12] /Margins[0 0]>>setpagedevice
D [20/Aug/2010:10:21:31 -0600] [Job 8] Before copy_setup - %%Page: 1 1
D [20/Aug/2010:10:21:31 -0600] [Job 8] Before page loop - %%Page: 1 1
D [20/Aug/2010:10:21:31 -0600] [Job 8] Copying page 1...
D [20/Aug/2010:10:21:31 -0600] [Job 8] pagew = 588.0, pagel = 768.0
D [20/Aug/2010:10:21:31 -0600] [Job 8] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
D [20/Aug/2010:10:21:31 -0600] [Job 8] PageLeft = 12.0, PageRight = 600.0
D [20/Aug/2010:10:21:31 -0600] [Job 8] PageTop = 780.0, PageBottom = 12.0
D [20/Aug/2010:10:21:31 -0600] [Job 8] PageWidth = 612.0, PageLength = 792.0
D [20/Aug/2010:10:21:31 -0600] [Job 8] Copying page 2...
D [20/Aug/2010:10:21:31 -0600] [Job 8] pagew = 588.0, pagel = 768.0
D [20/Aug/2010:10:21:31 -0600] [Job 8] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
D [20/Aug/2010:10:21:31 -0600] [Job 8] PageLeft = 12.0, PageRight = 600.0
D [20/Aug/2010:10:21:31 -0600] [Job 8] PageTop = 780.0, PageBottom = 12.0
D [20/Aug/2010:10:21:31 -0600] [Job 8] PageWidth = 612.0, PageLength = 792.0
D [20/Aug/2010:10:21:31 -0600] [Job 8] Wrote 2 pages...
D [20/Aug/2010:10:21:31 -0600] PID 14374 (/usr/lib/cups/filter/pstops) exited with no errors.
D [20/Aug/2010:10:21:31 -0600] PID 14373 (/usr/lib/cups/filter/texttops) exited with no errors.
D [20/Aug/2010:10:21:31 -0600] [Job 8] ATTR: marker-colors=none,none,none,none
D [20/Aug/2010:10:21:31 -0600] cupsdMarkDirty(P-----)
D [20/Aug/2010:10:21:31 -0600] [Job 8] ATTR: marker-names="black ink","yellow ink","cyan ink","magenta ink"
D [20/Aug/2010:10:21:31 -0600] cupsdMarkDirty(P-----)
D [20/Aug/2010:10:21:31 -0600] [Job 8] ATTR: marker-types=ink,ink,ink,ink
D [20/Aug/2010:10:21:31 -0600] cupsdMarkDirty(P-----)
D [20/Aug/2010:10:21:31 -0600] [Job 8] ATTR: marker-levels=88,243,277,285
D [20/Aug/2010:10:21:31 -0600] cupsdMarkDirty(P-----)
D [20/Aug/2010:10:21:31 -0600] Discarding unused printer-state-changed event...
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -media-low-report
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -media-empty-warning
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -toner-low-report
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -toner-empty-warning
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -door-open-report
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -media-jam-warning
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -input-tray-missing-warning
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -output-tray-missing-warning
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -marker-supply-missing-warning
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -output-area-almost-full-report
D [20/Aug/2010:10:21:31 -0600] [Job 8] STATE: -output-area-full-warning
D [20/Aug/2010:10:21:31 -0600] [Job 8] backendRunLoop(print_fd=0, device_fd=5, snmp_fd=6, addr=0x22790cc, use_bc=1, side_cb=0xeca380)
I [20/Aug/2010:10:21:31 -0600] [Job 8] Starting GPL Ghostscript 8.71...
D [20/Aug/2010:10:21:31 -0600] [Job 8] Running /usr/bin/gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -sDEVICE=pxlcolor -sstdout=%stderr -r600 -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -dMediaPosition=0 -dBitsPerPixel=24 -dDuplex=false -sOUTPUTFILE=%stdout -c <</.HWMargins[12 12 12 12] /Margins[0 0]>>setpagedevice -f /var/spool/cups/tmp/pstopxl.Bl80Tp
D [20/Aug/2010:10:21:31 -0600] Discarding unused job-progress event...
D [20/Aug/2010:10:21:31 -0600] [Job 8] Read 4096 bytes of print data...
D [20/Aug/2010:10:21:31 -0600] [Job 8] ATTR: marker-levels=88,243,277,285
D [20/Aug/2010:10:21:31 -0600] cupsdMarkDirty(P-----)
D [20/Aug/2010:10:21:31 -0600] Discarding unused printer-state-changed event...
D [20/Aug/2010:10:21:31 -0600] [Job 8] Wrote 4096 bytes of print data...
D [20/Aug/2010:10:21:31 -0600] [Job 8] Read 4096 bytes of print data...
D [20/Aug/2010:10:21:31 -0600] [Job 8] Wrote 4096 bytes of print data...
D [20/Aug/2010:10:21:31 -0600] [Job 8] Read 4096 bytes of print data...
.......
.......
.......
D [20/Aug/2010:10:21:31 -0600] [Job 8] Read 11 bytes of print data...
D [20/Aug/2010:10:21:31 -0600] [Job 8] Wrote 11 bytes of print data...
I [20/Aug/2010:10:21:31 -0600] [Job 8] Print file sent, waiting for printer to finish...
D [20/Aug/2010:10:21:31 -0600] Discarding unused job-progress event...
D [20/Aug/2010:10:21:31 -0600] PID 14375 (/usr/lib/cups/filter/pstopxl) exited with no errors.
D [20/Aug/2010:10:21:32 -0600] [Job 8] ATTR: marker-levels=88,243,277,285
D [20/Aug/2010:10:21:32 -0600] cupsdMarkDirty(P-----)
D [20/Aug/2010:10:21:32 -0600] Discarding unused printer-state-changed event...
I [20/Aug/2010:10:21:32 -0600] [Job 8] Ready to print.
D [20/Aug/2010:10:21:32 -0600] Discarding unused job-progress event...
D [20/Aug/2010:10:21:32 -0600] PID 14376 (/usr/lib/cups/backend/dnssd) exited with no errors.
D [20/Aug/2010:10:21:32 -0600] Discarding unused job-completed event...
I [20/Aug/2010:10:21:32 -0600] [Job 8] Job completed.
D [20/Aug/2010:10:21:32 -0600] cupsdMarkDirty(----J-)
D [20/Aug/2010:10:21:32 -0600] Discarding unused printer-state-changed event...
D [20/Aug/2010:10:21:33 -0600] [Job 8] Unloading...
D [20/Aug/2010:10:21:43 -0600] cupsdNetIFUpdate: "lo" = localhost:631
D [20/Aug/2010:10:21:43 -0600] cupsdNetIFUpdate: "eth0" = pdc0.cospringsit.com:631
D [20/Aug/2010:10:21:43 -0600] cupsdNetIFUpdate: "lo" = localhost:631
D [20/Aug/2010:10:21:43 -0600] cupsdNetIFUpdate: "eth0" = fe80::203:47ff:fefc:7c19%eth0:631
D [20/Aug/2010:10:21:43 -0600] Report: clients=0
D [20/Aug/2010:10:21:43 -0600] Report: jobs=8
D [20/Aug/2010:10:21:43 -0600] Report: jobs-active=0
D [20/Aug/2010:10:21:43 -0600] Report: printers=2
D [20/Aug/2010:10:21:43 -0600] Report: printers-implicit=0
D [20/Aug/2010:10:21:43 -0600] Report: stringpool-string-count=3293
D [20/Aug/2010:10:21:43 -0600] Report: stringpool-alloc-bytes=8040
D [20/Aug/2010:10:21:43 -0600] Report: stringpool-total-bytes=62400
I [20/Aug/2010:10:22:02 -0600] Saving printers.conf...
I [20/Aug/2010:10:22:02 -0600] Saving job cache file "/var/cache/cups/job.cache"...
D [20/Aug/2010:10:22:02 -0600] cupsdSetBusyState: Not busy
Does anybody have any ideas on how to even begin debugging this problem?

Thanks in advance for any replies...
# 2  
Old 08-25-2010
Further update for anyone that runs into this issue:

The problem resolved itself when I installed the "hplic" drivers. This has a whole bunch of dependencies, and so ended up installing a lot, but the setup now seems to work with the drivers provided by "hp-setp" binary that gets installed with the hplic package.

Further note of caution:

I was using both a network (hp) printer as well as a USB one (both Deskjet series I believe), and whereas hplic provided the correct drivers for the network printer, but the issues with the USB printer still remain (although hp-setup was able to find that printer and reported successful completion).
Login or Register to Ask a Question

Previous Thread | Next Thread

10 More Discussions You Might Find Interesting

1. UNIX for Dummies Questions & Answers

Strange mget problem

Hi! I'm a bit of a unix n00b so be gentle! I need to use ftp to download some files. I have the ftp running in a shell script which had been working perfectly last week. I downloaded around 400 files before it broke on friday. Now whenever I try to run the script, it starts to download... (3 Replies)
Discussion started by: johnnybongo
3 Replies

2. Shell Programming and Scripting

strange problem

hello all, i am having problem in accessing a directory.I dont think its a permission issue.can anyone help me out. I am using korn sell code: $ ls -ltr sc* lrwxrwxrwx 1 essbase essbase 21 Oct 8 2010 sc_ssp -> /work/nfs/nas2/sc_ssp $ cd sc_ssp ksh: sc_ssp: not found $ (6 Replies)
Discussion started by: manid
6 Replies

3. Shell Programming and Scripting

Strange Problem

Hi All, I am encountering an unexpected problem while running my process, using daemon placed in /etc/init.d/. I have a process that is opening shared library using dlopen. When I run my process on the command line, it is able to open the library. But when I used daemon to run my process, I... (0 Replies)
Discussion started by: qwerty-1
0 Replies

4. Red Hat

Problem with compileing CUPS

Hi guys, I'm trying to install a newer version of CUPS and my compilation fails: # ./configure checking for gawk... gawk checking for gcc... gcc checking for C compiler default output file name... a.out checking whether the C compiler works... yes checking whether we are cross compiling...... (4 Replies)
Discussion started by: eliraza6
4 Replies

5. Shell Programming and Scripting

Strange problem.

Well, my script started off to do what i wanted. Now, i think its not recognizing the pattern so its not moving anything. What i have to do is execute my script command for the move to take effect. So i did that and yayy it worked. Strange thing is that my DESTDIR was empty to begin with.... (2 Replies)
Discussion started by: oxoxo
2 Replies

6. Shell Programming and Scripting

Strange problem

I am using SunOS 5.9 and I don't know why all my commands are getting executed as if an extra 'enter' has been pressed. What could be the reason and how to correct it? Please help. Asty (2 Replies)
Discussion started by: Asty
2 Replies

7. Linux

very strange problem

I have installed Fedora Core on a Toshiba Satellite Pro4600 laptop recently I have experienced a rather mysterious problem if I touch anything specially the keyboard or mouse I see this stuff “67yujhnmyyy” straight away some time it won't stop for while like this... (5 Replies)
Discussion started by: kemobyte
5 Replies

8. UNIX for Dummies Questions & Answers

strange...problem

Hi.. Some of my application were not running properly due to lack of virtual memory.....so wht i did add one free harddisk as swap file system...and increased the swap memory.. But since than my root file system is showing 100% full thr is no space left...is thr any link between these two..... (1 Reply)
Discussion started by: Prafulla
1 Replies

9. UNIX for Dummies Questions & Answers

Strange Problem

I did an installation of Redhat 7.1 and it seem to install smoothly. I go and reboot and I get the following message: "INIT: Id "x" respawing too fast: disabled for 5 minutes" The screen flashes 4 times every 10 seconds or so. I can't seem to figure why this does this. It might be a simple... (2 Replies)
Discussion started by: forjohnny
2 Replies

10. UNIX for Dummies Questions & Answers

Strange problem.Please Help !

I¡¯m a network operator, mine is an IBM PC server 320, operating system SCO unix 3.2v4.2, triton 3.1 of Baan. Recently, my server went dead every a few hours, no sign & signal shows malfunction suddenly. It looks like a sudden power failure, but the indicator of main power supply is on. Normal... (1 Reply)
Discussion started by: lyhsm
1 Replies
Login or Register to Ask a Question