Package: libhpmud0
Version: 3.22.10+dfsg0-2
Control: affects -1 hplip hplip-data colord
In my journal I discovered an error
colord-sane[1000]: io/hpmud/musb.c 2101: Invalid usb_open: Permission denied
The part “io/hpmud/musb.c 2101: Invalid usb_open: Permission denied” is red. 
The message appears during boot; a hopefully relevant part of the journal is 
attached. The computer has many USB-A ports, and by default lots of stuff is 
connected to them (a mouse, a keyboard, an HP printer, an HP all-in-one (used 
only as a scanner), and sometimes an external USB thumb drive; the printer and 
the scanner usually sleep or are off at boot).  It would be great if we could 
see an indication of which port was tried to get opened (the identifier of the 
USB port is unlikely to be a privacy concern) because connecting and 
disconnecting stuff and rebooting for the purpose of debugging may be 
difficult. (In my special case, plugging/unplugging the cables on the 
particular computer is physically tedious, and rebooting takes lots of time. 
Other folks might find rebooting difficult, e.g., in case of highly available 
servers.)
Further, the red message is unlikely to be a hardware bug because all devices 
seem to work to the extent of my knowledge with Windows (the printer and the 
scanner seem to work once you awake them from sleep or turn them on).  The fact 
that certain devices are connected to the computer and are simply asleep does 
not constitute a user error warranting red color but is normal behavior and 
should be treated as such. Of course, also the permissions of the USB device in 
the file system might be wrong for whatever reason. So I speculate that the red 
message is likely to be a software issue. I can't speculate further without 
better error reporting.
The package colord in version 1.4.6-2.2 is installed.
Nitpickung for hard-boiled purists: `if (hd == NULL)` in musb.c should be 
simplified to `if(!hd)`. 😊
Gratefully,
AlMa
Jul 30 23:39:45 AnonymizedMachineName dbus-daemon[871]: [system] Activating via 
systemd: service name='org.freedesktop.ColorManager' unit='colord.service' 
requested by ':1.14' (uid=0 pid=957 comm="/usr/sbin/cupsd -l")
Jul 30 23:39:45 AnonymizedMachineName sshd[975]: Server listening on 0.0.0.0 
port 22.
Jul 30 23:39:45 AnonymizedMachineName sshd[975]: Server listening on :: port 22.
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Starting colord.service - 
Manage, Install and Generate Color Profiles...
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Started ssh.service - OpenBSD 
Secure Shell server.
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Started ModemManager.service 
- Modem Manager.
Jul 30 23:39:45 AnonymizedMachineName kernel: NET: Registered PF_QIPCRTR 
protocol family
Jul 30 23:39:45 AnonymizedMachineName udev-configure-printer[869]: device 
devpath is /devices/pci0000:00/0000:00:14.0/usb1/1-11
Jul 30 23:39:45 AnonymizedMachineName udev-configure-printer[869]: MFG:hp 
MDL:deskjet 5600 SERN:AnonymizedSerialNumber serial:AnonymizedSerialNumber
Jul 30 23:39:45 AnonymizedMachineName colord[976]: failed to get edid data: 
EDID length is too small
Jul 30 23:39:45 AnonymizedMachineName dbus-daemon[871]: [system] Successfully 
activated service 'org.freedesktop.ColorManager'
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Started colord.service - 
Manage, Install and Generate Color Profiles.
Jul 30 23:39:45 AnonymizedMachineName dbus-daemon[871]: [system] Successfully 
activated service 'org.freedesktop.hostname1'
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Started 
systemd-hostnamed.service - Hostname Service.
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5362] hostname: hostname: using hostnamed
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5363] hostname: static hostname changed from (none) to 
"AnonymizedMachineName"
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5365] dns-mgr: init: dns=default,systemd-resolved 
rc-manager=symlink (auto)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5370] rfkill0: found Wi-Fi radio killswitch (at 
/sys/devices/pci0000:b2/0000:b2:00.0/0000:b3:00.0/ieee80211/phy0/rfkill0) 
(driver iwlwifi)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5371] manager[0x5591bef93000]: rfkill: Wi-Fi hardware radio set 
enabled
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5371] manager[0x5591bef93000]: rfkill: WWAN hardware radio set 
enabled
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5405] Loaded device plugin: NMWwanFactory 
(/usr/lib/x86_64-linux-gnu/NetworkManager/1.42.4/libnm-device-plugin-wwan.so)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5420] Loaded device plugin: NMTeamFactory 
(/usr/lib/x86_64-linux-gnu/NetworkManager/1.42.4/libnm-device-plugin-team.so)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5427] Loaded device plugin: NMWifiFactory 
(/usr/lib/x86_64-linux-gnu/NetworkManager/1.42.4/libnm-device-plugin-wifi.so)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5437] Loaded device plugin: NMBluezManager 
(/usr/lib/x86_64-linux-gnu/NetworkManager/1.42.4/libnm-device-plugin-bluetooth.so)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5441] Loaded device plugin: NMAtmManager 
(/usr/lib/x86_64-linux-gnu/NetworkManager/1.42.4/libnm-device-plugin-adsl.so)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5443] manager: rfkill: Wi-Fi enabled by radio killswitch; enabled 
by state file
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5443] manager: rfkill: WWAN enabled by radio killswitch; enabled by 
state file
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5444] manager: Networking is enabled by state file
Jul 30 23:39:45 AnonymizedMachineName dbus-daemon[871]: [system] Activating via 
systemd: service name='org.freedesktop.nm_dispatcher' 
unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.10' (uid=0 
pid=901 comm="/usr/sbin/NetworkManager --no-daemon")
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5450] settings: Loaded settings plugin: ifupdown 
("/usr/lib/x86_64-linux-gnu/NetworkManager/1.42.4/libnm-settings-plugin-ifupdown.so")
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5450] settings: Loaded settings plugin: keyfile (internal)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5450] ifupdown: management mode: unmanaged
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5450] ifupdown:       interface-parser: parsing file 
/etc/network/interfaces
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5450] ifupdown:       interface-parser: source line includes 
interfaces file(s) /etc/network/interfaces.d/*
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5451] ifupdown:       interface-parser: parsing file 
/etc/network/interfaces.d/setup
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5451] ifupdown:       interface-parser: finished parsing file 
/etc/network/interfaces.d/setup
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5451] ifupdown:       interface-parser: finished parsing file 
/etc/network/interfaces
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5454] ifupdown: guessed connection type (enp6s0) = 802-3-ethernet
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5458] ifupdown: guessed connection type (enp7s0) = 802-3-ethernet
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Starting 
NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service...
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Started gdm.service - GNOME 
Display Manager.
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5494] dhcp: init: Using DHCP client 'internal'
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5497] manager: (lo): new Loopback device 
(/org/freedesktop/NetworkManager/Devices/1)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5505] device (lo): state change: unmanaged -> unavailable (reason 
'connection-assumed', sys-iface-state: 'external')
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5508] device (lo): state change: unavailable -> disconnected 
(reason 'connection-assumed', sys-iface-state: 'external')
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5513] device (lo): Activation: starting connection 'lo' 
(AnonymizedUUID)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5521] manager: (enp6s0): new Ethernet device 
(/org/freedesktop/NetworkManager/Devices/2)
Jul 30 23:39:45 AnonymizedMachineName dbus-daemon[871]: [system] Successfully 
activated service 'org.freedesktop.nm_dispatcher'
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Started 
NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service.
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5532] manager: (enp7s0): new Ethernet device 
(/org/freedesktop/NetworkManager/Devices/3)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5537] device (wlp179s0): driver supports Access Point (AP) mode
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5542] manager: (wlp179s0): new 802.11 Wi-Fi device 
(/org/freedesktop/NetworkManager/Devices/4)
Jul 30 23:39:45 AnonymizedMachineName NetworkManager[901]: <info>  
[1690753185.5544] device (wlp179s0): state change: unmanaged -> unavailable 
(reason 'managed', sys-iface-state: 'external')
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Received SIGRTMIN+21 from PID 
307 (plymouthd).
Jul 30 23:39:45 AnonymizedMachineName gdm-launch-environment][992]: 
pam_unix(gdm-launch-environment:session): session opened for user 
Debian-gdm(uid=119) by (uid=0)
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Created slice user-119.slice 
- User Slice of UID 119.
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Starting 
user-runtime-dir@119.service - User Runtime Directory /run/user/119...
Jul 30 23:39:45 AnonymizedMachineName systemd-logind[886]: New session c1 of 
user Debian-gdm.
Jul 30 23:39:45 AnonymizedMachineName acpid[865]: starting up with netlink and 
the input layer
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Finished 
user-runtime-dir@119.service - User Runtime Directory /run/user/119.
Jul 30 23:39:45 AnonymizedMachineName acpid[865]: 27 rules loaded
Jul 30 23:39:45 AnonymizedMachineName acpid[865]: waiting for events: event 
logging is off
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Starting user@119.service - 
User Manager for UID 119...
Jul 30 23:39:45 AnonymizedMachineName (systemd)[1006]: 
pam_unix(systemd-user:session): session opened for user Debian-gdm(uid=119) by 
(uid=0)
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Started udisks2.service - 
Disk Manager.
Jul 30 23:39:45 AnonymizedMachineName audit[957]: AVC apparmor="DENIED" 
operation="capable" profile="/usr/sbin/cupsd" pid=957 comm="cupsd" 
capability=12  capname="net_admin"
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Started cups.service - CUPS 
Scheduler.
Jul 30 23:39:45 AnonymizedMachineName systemd[1]: Reached target printer.target 
- Printer Support.
Jul 30 23:39:45 AnonymizedMachineName colord-sane[1000]: io/hpmud/musb.c 2101: 
Invalid usb_open: Permission denied

Reply via email to