Ubuntu
cupsys package

  1. Bug #153003
  2. Comment #10

Comment 10 for bug 153003

Revision history for this message
Peter Peltonen (peter-peltonen) wrote :

I think I have the same problem: with HP 710C parallel port printer which used to work ok but when I now try to print something nothing happens. The only error msg I can find is in 'dmesg':

[ 51.118333] audit(1203613684.366:3): type=1503 operation="inode_permission" requested_mask="a" denied_mask="a" name="/dev/tty" pid=5313 profile="/usr/sbin/cupsd"

lpinfo sees the port:

root@sinisusi:~# lpinfo -v
network socket
network beh
direct hpfax
direct hp
network http
network ipp
network lpd
direct parallel:/dev/lp0
file cups-pdf:/
direct scsi
network smb

lpq reports that everything is okay:

root@sinisusi:~# lpq
hp710gray is ready
no entries

CUPS access log claims everything printed just fine:

localhost - - [21/Feb/2008:19:29:46 +0200] "POST / HTTP/1.1" 200 416 CUPS-Get-Classes successful-ok
localhost - - [21/Feb/2008:19:29:46 +0200] "POST /printers/hp710gray HTTP/1.1" 200 347 Print-Job successful-ok

CUPS error log also seems to say that the document printed fine:

D [21/Feb/2008:19:29:46 +0200] cupsdAcceptClient: 11 from localhost:631 (IPv4)
D [21/Feb/2008:19:29:46 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [21/Feb/2008:19:29:46 +0200] cupsdAuthorize: No authentication data provided.
D [21/Feb/2008:19:29:46 +0200] CUPS-Get-Printers
D [21/Feb/2008:19:29:46 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [21/Feb/2008:19:29:46 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [21/Feb/2008:19:29:46 +0200] cupsdAuthorize: No authentication data provided.
D [21/Feb/2008:19:29:46 +0200] CUPS-Get-Classes
D [21/Feb/2008:19:29:46 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [21/Feb/2008:19:29:46 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [21/Feb/2008:19:29:46 +0200] cupsdAuthorize: No authentication data provided.
D [21/Feb/2008:19:29:46 +0200] CUPS-Get-Default
D [21/Feb/2008:19:29:46 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [21/Feb/2008:19:29:46 +0200] cupsdCloseClient: 11
D [21/Feb/2008:19:29:46 +0200] cupsdAcceptClient: 11 from localhost:631 (IPv4)
D [21/Feb/2008:19:29:46 +0200] cupsdReadClient: 11 POST /printers/hp710gray HTTP/1.1
D [21/Feb/2008:19:29:46 +0200] cupsdAuthorize: No authentication data provided.
D [21/Feb/2008:19:29:46 +0200] Print-Job ipp://localhost/printers/hp710gray
D [21/Feb/2008:19:29:46 +0200] print_job: auto-typing file...
D [21/Feb/2008:19:29:46 +0200] add_job: requesting-user-name="root"
I [21/Feb/2008:19:29:46 +0200] [Job 163] Adding start banner page "none".
D [21/Feb/2008:19:29:46 +0200] Discarding unused job-created event...
I [21/Feb/2008:19:29:46 +0200] [Job 163] Adding job file of type text/plain.
I [21/Feb/2008:19:29:46 +0200] [Job 163] Adding end banner page "none".
I [21/Feb/2008:19:29:46 +0200] [Job 163] Queued on "hp710gray" by "root".
D [21/Feb/2008:19:29:46 +0200] [Job 163] hold_until = 0
D [21/Feb/2008:19:29:46 +0200] [Job 163] Sending job to queue tagged as raw...
D [21/Feb/2008:19:29:46 +0200] Discarding unused printer-state-changed event...
D [21/Feb/2008:19:29:46 +0200] [Job 163] job-sheets=none,none
D [21/Feb/2008:19:29:46 +0200] [Job 163] banner_page = 0
D [21/Feb/2008:19:29:46 +0200] [Job 163] argv[0]="hp710gray"
D [21/Feb/2008:19:29:46 +0200] [Job 163] argv[1]="163"
D [21/Feb/2008:19:29:46 +0200] [Job 163] argv[2]="root"
D [21/Feb/2008:19:29:46 +0200] [Job 163] argv[3]="foo"
D [21/Feb/2008:19:29:46 +0200] [Job 163] argv[4]="1"
D [21/Feb/2008:19:29:46 +0200] [Job 163] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:0b9ca6ea-a057-3eaf-4de7-24e73d95c521"
D [21/Feb/2008:19:29:46 +0200] [Job 163] argv[6]="/var/spool/cups/d00163-001"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[9]="<email address hidden>"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[10]="SOFTWARE=CUPS/1.3.2"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[12]="TZ=Europe/Helsinki"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[13]="USER=root"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[14]="CUPS_SERVER=localhost"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[16]="IPP_PORT=631"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[17]="CHARSET=utf-8"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[18]="LANG=en_US"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[19]="PPD=/etc/cups/ppd/hp710gray.ppd"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[20]="RIP_MAX_CACHE=8m"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[21]="CONTENT_TYPE=text/plain"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[22]="DEVICE_URI=parallel:/dev/lp0"
D [21/Feb/2008:19:29:46 +0200] [Job 163] envp[23]="PRINTER=hp710gray"
I [21/Feb/2008:19:29:46 +0200] [Job 163] Started backend /usr/lib/cups/backend/parallel (PID 6287)
D [21/Feb/2008:19:29:46 +0200] Discarding unused job-state event...
D [21/Feb/2008:19:29:46 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [21/Feb/2008:19:29:46 +0200] cupsdCloseClient: 11
D [21/Feb/2008:19:29:46 +0200] Discarding unused printer-state-changed event...
D [21/Feb/2008:19:29:46 +0200] Discarding unused job-progress event...
D [21/Feb/2008:19:29:46 +0200] [Job 163] backendRunLoop(print_fd=5, device_fd=6, use_bc=0, side_cb=0x8049560)
D [21/Feb/2008:19:29:46 +0200] [Job 163] Read 5 bytes of print data...
D [21/Feb/2008:19:29:46 +0200] Discarding unused printer-state-changed event...
D [21/Feb/2008:19:29:46 +0200] [Job 163] Wrote 5 bytes of print data...
D [21/Feb/2008:19:29:46 +0200] Discarding unused printer-state-changed event...
D [21/Feb/2008:19:29:46 +0200] PID 6287 (/usr/lib/cups/backend/parallel) exited with no errors.
D [21/Feb/2008:19:29:46 +0200] [Job 163] File 0 is complete.
I [21/Feb/2008:19:29:46 +0200] [Job 163] Completed successfully.
D [21/Feb/2008:19:29:46 +0200] Discarding unused printer-state-changed event...
D [21/Feb/2008:19:29:46 +0200] Discarding unused job-completed event...
D [21/Feb/2008:19:29:47 +0200] [Job 163] Unloading...

I tried disabling AppArmor with

root@sinisusi:~# aa-complain cupsd

but this makes no difference.

The other thing I've noticed is that if in KDE i do "System Settings" -> "Printers" I get System Settings to crash (backtrace attached).