HPLIP

Officejet_Pro_8500_A909g unable to print in Fedora 11 with hp:/net/Officejet_Pro_8500_A909g?zc=hp8500

Bug #427541 reported by James Boulton
12
This bug affects 2 people
Affects Status Importance Assigned to Milestone
HPLIP
New
Undecided
Unassigned

Bug Description

When I setup the printer with the print queue seto to:
hp:/net/Officejet_Pro_8500_A909g?zc=hp8500

hp8500 is the local dns name of the printer.

In /var/log/messages I get:

Sep 11 08:26:53 stearman kernel: type=1400 audit(1252614413.764:13969): avc: denied { name_bind } for pid=2374 comm="hpcups" src=5353 scontext=system_u:system_r:cupsd_t:s0-s0:c0.c1023 tcontext=system_u:object_r:howl_port_t:s0 tclass=udp_socket
Sep 11 08:26:53 stearman Officejet_Pro_8500_A909g: io/hpmud/jd.c 691: unable to bind udp socket: Permission denied
Sep 11 08:26:57 stearman Officejet_Pro_8500_A909g: io/hpmud/jd.c 88: unable to read device-id
Sep 11 08:26:57 stearman kernel: type=1400 audit(1252614417.854:13970): avc: denied { name_bind } for pid=2375 comm="hp" src=5353 scontext=system_u:system_r:hplip_t:s0-s0:c0.c1023 tcontext=system_u:object_r:howl_port_t:s0 tclass=udp_socket
Sep 11 08:26:57 stearman hp[2375]: io/hpmud/jd.c 691: unable to bind udp socket: Permission denied
Sep 11 08:27:00 stearman hp[2375]: io/hpmud/jd.c 88: unable to read device-id
Sep 11 08:27:00 stearman hp[2375]: prnt/backend/hp.c 728: ERROR: cannot open device stat=12: hp:/net/Officejet_Pro_8500_A909g?zc=hp8500
Sep 11 08:27:00 stearman Officejet_Pro_8500_A909g: prnt/hpijs/services.cpp 386: unable to write to output, fd=1, count=4096: Broken pipe
Sep 11 08:27:00 stearman Officejet_Pro_8500_A909g: prnt/hpijs/services.cpp 386: unable to write to output, fd=1, count=4096: Broken pipe
Sep 11 08:27:00 stearman Officejet_Pro_8500_A909g: prnt/hpijs/services.cpp 386: unable to write to output, fd=1, count=4096: Broken pipe
Sep 11 08:27:00 stearman Officejet_Pro_8500_A909g: prnt/hpijs/services.cpp 386: unable to write to output, fd=1, count=4096: Broken pipe
Sep 11 08:27:00 stearman Officejet_Pro_8500_A909g: prnt/hpijs/services.cpp 386: unable to write to output, fd=1, count=4096: Broken pipe
Sep 11 08:29:57 stearman ntpd[1564]: synchronized to 119.47.118.129, stratum 3
Sep 11 08:29:57 stearman ntpd[1564]: kernel time sync status change 2001
Sep 11 08:33:12 stearman ntpd[1564]: synchronized to 218.185.224.7, stratum 2
Sep 11 08:33:56 stearman Officejet_Pro_8500_A909g: io/hpmud/jd.c 691: unable to bind udp socket: Permission denied
Sep 11 08:33:56 stearman kernel: type=1400 audit(1252614836.643:13971): avc: denied { name_bind } for pid=2614 comm="hpcups" src=5353 scontext=system_u:system_r:cupsd_t:s0-s0:c0.c1023 tcontext=system_u:object_r:howl_port_t:s0 tclass=udp_socket
Sep 11 08:33:59 stearman Officejet_Pro_8500_A909g: io/hpmud/jd.c 88: unable to read device-id
Sep 11 08:33:59 stearman hp[2615]: io/hpmud/jd.c 691: unable to bind udp socket: Permission denied
Sep 11 08:33:59 stearman kernel: type=1400 audit(1252614839.745:13972): avc: denied { name_bind } for pid=2615 comm="hp" src=5353 scontext=system_u:system_r:hplip_t:s0-s0:c0.c1023 tcontext=system_u:object_r:howl_port_t:s0 tclass=udp_socket
Sep 11 08:34:02 stearman hp[2615]: io/hpmud/jd.c 88: unable to read device-id
Sep 11 08:34:02 stearman hp[2615]: prnt/backend/hp.c 728: ERROR: cannot open device stat=12: hp:/net/Officejet_Pro_8500_A909g?zc=hp8500
Sep 11 08:34:02 stearman Officejet_Pro_8500_A909g: prnt/hpijs/services.cpp 386: unable to write to output, fd=1, count=4096: Broken pipe
Sep 11 08:34:02 stearman Officejet_Pro_8500_A909g: prnt/hpijs/services.cpp 386: unable to write to output, fd=1, count=4096: Broken pipe
Sep 11 08:34:02 stearman Officejet_Pro_8500_A909g: prnt/hpijs/services.cpp 386: unable to write to output, fd=1, count=4096: Broken pipe
Sep 11 08:34:02 stearman Officejet_Pro_8500_A909g: prnt/hpijs/services.cpp 386: unable to write to output, fd=1, count=4096: Broken pipe
Sep 11 08:34:02 stearman Officejet_Pro_8500_A909g: prnt/hpijs/services.cpp 386: unable to write to output, fd=1, count=4096: Broken pipe

However if I change the print queue to:

hp:/net/Officejet_Pro_8500_A909g?ip=192.168.117.13

Everything works

Revision history for this message
Suma Byrappa (suma-byrappa) wrote :

Hi,

From the logs, I see that the HPLIP components - hpcups and hp - are failing to bind to the socket (or port) through which it can communicate with the device. As you mentioned that when you have the URI to contain ip address explicitly it works, it looks like resolving "zc=hp8500" part in the URI to ip address and port is failing. This could likely be an problem with permission (or previlege).

Could you please post the output from running the command "hp-check -g"?

Thanks,
Suma

Revision history for this message
James Boulton (j-boulton) wrote :
Download full text (123.3 KiB)

hp-check[2984]: info: :
Initializing. Please wait...
hp-check[2984]: debug: ['unknown', 'mepis', 'debian', 'suse', 'mandriva', 'fedora', 'redhat', 'rhel', 'slackware', 'gentoo', 'redflag', 'ubuntu', 'xandros', 'freebsd', 'linspire', 'ark', 'pclinuxos', 'centos', 'igos', 'linuxmint', 'linpus', 'gos', 'boss', 'lfs']
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:libcrypto]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:gs]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:python23]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:libnetsnmp-devel]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:sane-devel]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:pil]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:cups]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:gcc]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:pyqt4-dbus]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:libpthread]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:make]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:python-devel]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:cups-devel]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:scanimage]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:python-dbus]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:cups-ddk]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:reportlab]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:pyqt4]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:libusb]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:libtool]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:cups-image]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:policykit]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:python-xml]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:python-notify]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:xsane]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:libjpeg]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:dbus]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:sane]
hp-check[2984]: debug: Missing dependency section in distros.dat: [unknown:0:python2x]
hp-check[2984]: debug: Missing dependency section in distros.dat: [mepis:6.0:policykit]
hp-check[2984]: debug: Missing dependency section in distros.dat: [mepis:6.0:python-xml]
hp-check[2984]: debug: Missing dependency section in distros.dat: [mepis:6.0:python-notify]
hp-check[2984]: debug: Missing dependency section in distros.dat: [mepis:6.0:dbus]
hp-check[2984]:...

Revision history for this message
dwelch91 (dwelch91) wrote : Re: [Bug 427541] Re: Officejet_Pro_8500_A909g unable to print in Fedora 11 with hp:/net/Officejet_Pro_8500_A909g?zc=hp8500
Download full text (129.5 KiB)

You should be running "hp-check -t" not "hp-check -g". All that "missing
dependency" stuff is superfluous.

On Thu, Oct 22, 2009 at 11:57 AM, James Boulton <email address hidden>wrote:

> hp-check[2984]: info: :
> Initializing. Please wait...
> hp-check[2984]: debug: ['unknown', 'mepis', 'debian', 'suse', 'mandriva',
> 'fedora', 'redhat', 'rhel', 'slackware', 'gentoo', 'redflag', 'ubuntu',
> 'xandros', 'freebsd', 'linspire', 'ark', 'pclinuxos', 'centos', 'igos',
> 'linuxmint', 'linpus', 'gos', 'boss', 'lfs']
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:libcrypto]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:gs]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:python23]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:libnetsnmp-devel]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:sane-devel]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:pil]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:cups]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:gcc]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:pyqt4-dbus]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:libpthread]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:make]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:python-devel]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:cups-devel]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:scanimage]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:python-dbus]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:cups-ddk]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:reportlab]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:pyqt4]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:libusb]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:libtool]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:cups-image]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:policykit]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:python-xml]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:python-notify]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:xsane]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:libjpeg]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:dbus]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:sane]
> hp-check[2984]: debug: Missing dependency section in distros.dat:
> [unknown:0:python2x]
> hp-check[2984]: debug: Missing dependency secti...

Revision history for this message
James Boulton (j-boulton) wrote :
Download full text (12.9 KiB)

Here is the log from hp-check -t:
hp-check[5833]: info: :
Initializing. Please wait...
Fedora

11

scheduler is running

1.4.1

Linux stearman.veritide.co.nz 2.6.30.8-64.fc11.x86_64 #1 SMP Fri Sep 25 04:43:32 EDT 2009 x86_64 x86_64 x86_64 GNU/Linux

hp-check[5833]: info: :
hp-check[5833]: info: :---------------
hp-check[5833]: info: :| SYSTEM INFO |
hp-check[5833]: info: :---------------
hp-check[5833]: info: :
hp-check[5833]: info: :Basic system information:
hp-check[5833]: info: :Linux stearman.veritide.co.nz 2.6.30.8-64.fc11.x86_64 #1 SMP Fri Sep 25 04:43:32 EDT 2009 x86_64 x86_64 x86_64 GNU/Linux

hp-check[5833]: info: :
hp-check[5833]: info: :Distribution:
hp-check[5833]: info: :fedora 11
hp-check[5833]: info: :
hp-check[5833]: info: :Checking Python version...
hp-check[5833]: info: :OK, version 2.6.0 installed
hp-check[5833]: info: :
hp-check[5833]: info: :Checking PyQt 4.x version...
hp-check[5833]: info: :OK, version 4.5.4 installed.
hp-check[5833]: info: :
hp-check[5833]: info: :Checking for CUPS...
hp-check[5833]: info: :Status: scheduler is running
hp-check[5833]: info: :Version: 1.4.1
hp-check[5833]: info: :error_log is set to level: warn
hp-check[5833]: info: :
hp-check[5833]: info: :Checking for dbus/python-dbus...
hp-check[5833]: info: :dbus daemon is running.
hp-check[5833]: info: :python-dbus version: 0.83.0
hp-check[5833]: info: :
hp-check[5833]: info: :
hp-check[5833]: info: :------------------------------------
hp-check[5833]: info: :| COMPILE AND RUNTIME DEPENDENCIES |
hp-check[5833]: info: :------------------------------------
hp-check[5833]: info: :
note: To check for compile-time only dependencies, re-run hp-check with the -c parameter (ie, hp-check -c).
note: To check for run-time only dependencies, re-run hp-check with the -r parameter (ie, hp-check -r).
hp-check[5833]: info: :
hp-check[5833]: info: :Checking for dependency: CUPS - Common Unix Printing System...
hp-check[5833]: info: :OK, found.
hp-check[5833]: info: :
hp-check[5833]: info: :Checking for dependency: CUPS DDK - CUPS driver development kit...
warning: NOT FOUND! This is an OPTIONAL/RUNTIME ONLY dependency. Some HPLIP functionality may not function properly.
hp-check[5833]: info: :To install this dependency, execute this command:
hp-check[5833]: info: :su -c "yum -y -d 10 -e 1 install cupsddk cupsddk-drivers cupsddk-devel"
hp-check[5833]: info: :
hp-check[5833]: info: :Checking for dependency: CUPS devel- Common Unix Printing System development files...
hp-check[5833]: info: :OK, found.
hp-check[5833]: info: :
hp-check[5833]: info: :Checking for dependency: CUPS image - CUPS image development files...
hp-check[5833]: info: :OK, found.
hp-check[5833]: info: :
hp-check[5833]: info: :Checking for dependency: DBus - Message bus system...
hp-check[5833]: info: :OK, found.
hp-check[5833]: info: :
hp-check[5833]: info: :Checking for dependency: gcc - GNU Project C and C++ Compiler...
hp-check[5833]: info: :OK, found.
hp-check[5833]: info: :
hp-check[5833]: info: :Checking for dependency: GhostScript - PostScript and PDF language interpreter and previewer...
hp-check[5833]: info: :OK, found.
hp-check[5833]: info: :
hp-check[5833]: info: :Checking for depen...

Revision history for this message
Suma Byrappa (suma-byrappa) wrote :

Thanks Don, for pointing out the hp-check option to be "-t", I'd typed it wrong.

James, thanks for posting the output log. Can you try the following and let me know of the results.
1. Run hp-mkuri and hp-probe, and post the output.
2. Try installing your printer using "hp-setup", instead of using CUPS interface, and let me know if it helps.

Regards,
Suma

Revision history for this message
James Boulton (j-boulton) wrote :

Output for hp-probe:

HP Linux Imaging and Printing System (ver. 3.9.8)
Printer Discovery Utility ver. 4.1

Copyright (c) 2001-9 Hewlett-Packard Development Company, LP
This software comes with ABSOLUTELY NO WARRANTY.
This is free software, and you are welcome to distribute it
under certain conditions. See COPYING file for more details.

--------------------------------
| SELECT CONNECTION (I/O) TYPE |
 --------------------------------

  Num Connection Description
            Type
  -------- ---------- ----------------------------------------------------------
  0* usb Universal Serial Bus (USB)
  1 net Network/Ethernet/Wireless (direct connection or JetDirect)

Enter number 0...1 for connection type (q=quit, enter=usb*) ? 1

Using connection type: net

--------------------
| DEVICE DISCOVERY |
 --------------------

Probing network for printers. Please wait, this will take approx. 10 seconds...

  Device URI Model Name
  -------------------------------------------------- ------------------------ ------
  hp:/net/Officejet_Pro_8500_A909g?ip=192.168.117.13 Officejet_Pro_8500_A909g hp8500

Found 1 printer(s) on the 'net' bus.

Revision history for this message
James Boulton (j-boulton) wrote :

Output for "hp-mkuri -z hp8500"
hp:/net/Officejet_Pro_8500_A909g?zc=hp8500
hpaio:/net/Officejet_Pro_8500_A909g?zc=hp8500

Revision history for this message
James Boulton (j-boulton) wrote :

Setup with hp-setup still does not work. But we have a new clue. SELinux gives warning:

Summary:

SELinux is preventing hp (hplip_t) "name_bind" howl_port_t.

Detailed Description:

SELinux denied access requested by hp. It is not expected that this access is
required by hp and this access may signal an intrusion attempt. It is also
possible that the specific version or configuration of the application is
causing it to require additional access.

Allowing Access:

You can generate a local policy module to allow this access - see FAQ
(http://fedora.redhat.com/docs/selinux-faq-fc5/#id2961385) Or you can disable
SELinux protection altogether. Disabling SELinux protection is not recommended.
Please file a bug report (http://bugzilla.redhat.com/bugzilla/enter_bug.cgi)
against this package.

Additional Information:

Source Context system_u:system_r:hplip_t:s0-s0:c0.c1023
Target Context system_u:object_r:howl_port_t:s0
Target Objects None [ udp_socket ]
Source hp
Source Path /usr/lib/cups/backend/hp
Port 5353
Host stearman.veritide.co.nz
Source RPM Packages hplip-3.9.8-12.fc11
Target RPM Packages
Policy RPM selinux-policy-3.6.12-85.fc11
Selinux Enabled True
Policy Type targeted
MLS Enabled True
Enforcing Mode Enforcing
Plugin Name catchall
Host Name stearman.veritide.co.nz
Platform Linux stearman.veritide.co.nz
                              2.6.30.8-64.fc11.x86_64 #1 SMP Fri Sep 25 04:43:32
                              EDT 2009 x86_64 x86_64
Alert Count 1
First Seen Tue 27 Oct 2009 08:15:06 AM NZDT
Last Seen Tue 27 Oct 2009 08:15:06 AM NZDT
Local ID e125f4ca-288d-4de3-a758-3a47d3993102
Line Numbers

Raw Audit Messages

node=stearman.veritide.co.nz type=AVC msg=audit(1256584506.442:33766): avc: denied { name_bind } for pid=2814 comm="hp" src=5353 scontext=system_u:system_r:hplip_t:s0-s0:c0.c1023 tcontext=system_u:object_r:howl_port_t:s0 tclass=udp_socket

node=stearman.veritide.co.nz type=SYSCALL msg=audit(1256584506.442:33766): arch=c000003e syscall=49 success=no exit=-13 a0=6 a1=7fffd85453b0 a2=10 a3=7fffd8545094 items=0 ppid=1274 pid=2814 auid=4294967295 uid=4 gid=7 euid=4 suid=4 fsuid=4 egid=7 sgid=7 fsgid=7 tty=(none) ses=4294967295 comm="hp" exe="/usr/lib/cups/backend/hp" subj=system_u:system_r:hplip_t:s0-s0:c0.c1023 key=(null)

Revision history for this message
Suma Byrappa (suma-byrappa) wrote :

Hi James,

Try disabling SELinux. You can find more information at,

http://hplipopensource.com/node/332
http://www.crypt.gen.nz/selinux/disable_selinux.html

Regards,
Suma

To post a comment you must log in.
This report contains Public information  
Everyone can see this information.
Subscribing...

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.