eruption-project / eruption

Realtime RGB LED Driver for Linux
https://eruption-project.org/
GNU General Public License v3.0
258 stars 32 forks source link

Daemon Helper Service Lockup #219

Open alkaris2 opened 1 year ago

alkaris2 commented 1 year ago

Introduction Encountered a bug where Eruption Daemon Service locks up entirely with no keyboard input and unplugging and reconnecting keyboard does not recover input response when reconnected to the system. It appears to enter "dead" state on keyboard input and returns error that the device went away when it's still connected and in use

Please describe the bug This bug appears to be in relation with the helper service for Eruption the eruption-hotplug-helper.service which incorrectly deactivates itself.

To Reproduce Unsure how to reproduce, but when it bugged out no keyboard inputs were working. I had to remote into the PC via SSH to restart the daemon service for Eruption to restore keyboard input.

Logs

$ journalctl -xe | grep eruption
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: Mouse device went away: No such device (os error 19)
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: More than 82 milliseconds of jitter detected!
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: This means that we dropped at least one frame
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: Loop took: 196 milliseconds, goal: 41
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: Error sending LED map to a device: Device not opened
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: Could not process a mouse event: receiving on a closed channel
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: An error occurred while closing the device
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: Left the main loop due to an irrecoverable error: A device failed
░░ Subject: A start job for unit eruption-hotplug-helper.service has begun execution
░░ A start job for unit eruption-hotplug-helper.service has begun execution.
░░ Subject: A start job for unit eruption-hotplug-helper.service has finished successfully
░░ A start job for unit eruption-hotplug-helper.service has finished successfully.
Jun 30 22:41:53 tohru eruption[7818]: tohru eruption[7818]: Keyboard device went away: No such device (os error 19)
Jun 30 22:41:53 tohru eruption[7818]: tohru eruption[7818]: Trying to unplug the failed device
Jun 30 22:41:53 tohru eruption[7818]: tohru eruption[7818]: Skipping uninitialized device, trying to re-initialize it now...
Jun 30 22:41:53 tohru eruption[7818]: tohru eruption[7818]: Error opening the keyboard device: Could not open the device file
Jun 30 22:41:53 tohru eruption[7818]: tohru eruption[7818]: Could not initialize the device: Device not opened
Jun 30 22:41:54 tohru eruption[7818]: tohru eruption[7818]: Step 1: Invalid result
Jun 30 22:41:54 tohru systemd[1]: eruption-hotplug-helper.service: Deactivated successfully.
░░ The unit eruption-hotplug-helper.service has successfully entered the 'dead' state.
░░ Subject: A start job for unit eruption-hotplug-helper.service has begun execution
░░ A start job for unit eruption-hotplug-helper.service has begun execution.
░░ Subject: A start job for unit eruption-hotplug-helper.service has finished successfully
░░ A start job for unit eruption-hotplug-helper.service has finished successfully.
Jun 30 22:41:56 tohru systemd[1]: eruption-hotplug-helper.service: Deactivated successfully.
░░ The unit eruption-hotplug-helper.service has successfully entered the 'dead' state.
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Keyboard device went away: No such device (os error 19)
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Error sending LED map to a device: Invalid result
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [3]
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Trying to unplug the failed device
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [2]
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: An error occurred while closing the device
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [3]
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Skipping uninitialized device, trying to re-initialize it now...
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [2]
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Error opening the keyboard device: Could not open the device file
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [2]
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Could not initialize the device: Device not opened
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [2]
░░ Subject: A start job for unit eruption-hotplug-helper.service has begun execution
░░ A start job for unit eruption-hotplug-helper.service has begun execution.
░░ Subject: A start job for unit eruption-hotplug-helper.service has finished successfully
░░ A start job for unit eruption-hotplug-helper.service has finished successfully.
Jun 30 22:43:52 tohru systemd[1]: eruption-hotplug-helper.service: Deactivated successfully.
░░ The unit eruption-hotplug-helper.service has successfully entered the 'dead' state.
Jun 30 22:45:07 tohru dbus-daemon[690]: [system] Activating via systemd: service name='org.freedesktop.home1' unit='dbus-org.freedesktop.home1.service' requested by ':1.3162' (uid=0 pid=3790670 comm="sudo systemctl restart eruption")
Jun 30 22:45:17 tohru sudo[3790670]:  alkaris : TTY=pts/1 ; PWD=/home/alkaris ; USER=root ; COMMAND=/usr/bin/systemctl restart eruption
░░ Subject: A stop job for unit eruption.service has begun execution
░░ A stop job for unit eruption.service has begun execution.
Jun 30 22:45:17 tohru eruption-audio-[8652]: tohru eruption-audio-proxy[8652]: Socket error: Eruption disconnected
░░ Subject: A start job for unit eruption-hotplug-helper.service has begun execution
░░ A start job for unit eruption-hotplug-helper.service has begun execution.
░░ Subject: A start job for unit eruption-hotplug-helper.service has finished successfully
░░ A start job for unit eruption-hotplug-helper.service has finished successfully.
Jun 30 22:45:18 tohru eruption-audio-[8652]: tohru eruption-audio-proxy[8652]: Socket error: Eruption disconnected
Jun 30 22:45:18 tohru eruption-hotplug-helper[3791515]: Error:
Jun 30 22:45:18 tohru eruption-hotplug-helper[3791515]:    0: Lost connection to Eruption
Jun 30 22:45:18 tohru eruption-hotplug-helper[3791515]: Location:
Jun 30 22:45:18 tohru eruption-hotplug-helper[3791515]:    sdk/lib/rust/eruption-rs/src/transport/local.rs:110
Jun 30 22:45:18 tohru systemd[1]: eruption-hotplug-helper.service: Main process exited, code=exited, status=1/FAILURE
░░ An ExecStart= process belonging to unit eruption-hotplug-helper.service has exited.
Jun 30 22:45:18 tohru systemd[1]: eruption-hotplug-helper.service: Failed with result 'exit-code'.
░░ The unit eruption-hotplug-helper.service has entered the 'failed' state with result 'exit-code'.
Jun 30 22:45:18 tohru systemd[1]: eruption.service: Deactivated successfully.
░░ The unit eruption.service has successfully entered the 'dead' state.
░░ Subject: A stop job for unit eruption.service has finished
░░ A stop job for unit eruption.service has finished.
Jun 30 22:45:18 tohru systemd[1]: eruption.service: Consumed 5h 47min 44.603s CPU time.
░░ The unit eruption.service completed and consumed the indicated resources.
░░ Subject: A start job for unit eruption.service has begun execution
░░ A start job for unit eruption.service has begun execution.
░░ Subject: A start job for unit eruption.service has finished successfully
░░ A start job for unit eruption.service has finished successfully.
Jun 30 22:45:18 tohru eruption[3791546]: tohru eruption[3791546]: ** EXPERIMENTAL DRIVERS are ENABLED, this may expose serious bugs! **
Jun 30 22:45:20 tohru eruption[3791546]: tohru eruption[3791546]: Step 1: Invalid result
Jun 30 22:47:57 tohru dbus-daemon[690]: [system] Activating via systemd: service name='org.freedesktop.home1' unit='dbus-org.freedesktop.home1.service' requested by ':1.3169' (uid=0 pid=3798680 comm="sudo systemctl status eruption")
Jun 30 22:48:01 tohru sudo[3798680]:  alkaris : TTY=pts/0 ; PWD=/home/alkaris ; USER=root ; COMMAND=/usr/bin/systemctl status eruption
$ sudo journalctl -u eruption -b
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: Mouse device went away: No such device (os error 19)
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: More than 82 milliseconds of jitter detected!
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: This means that we dropped at least one frame
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: Loop took: 196 milliseconds, goal: 41
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: Error sending LED map to a device: Device not opened
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: Could not process a mouse event: receiving on a closed channel
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: An error occurred while closing the device
Jun 30 22:41:48 tohru eruption[7818]: tohru eruption[7818]: Left the main loop due to an irrecoverable error: A device failed
Jun 30 22:41:53 tohru eruption[7818]: tohru eruption[7818]: Keyboard device went away: No such device (os error 19)
Jun 30 22:41:53 tohru eruption[7818]: tohru eruption[7818]: Trying to unplug the failed device
Jun 30 22:41:53 tohru eruption[7818]: tohru eruption[7818]: Skipping uninitialized device, trying to re-initialize it now...
Jun 30 22:41:53 tohru eruption[7818]: tohru eruption[7818]: Error opening the keyboard device: Could not open the device file
Jun 30 22:41:53 tohru eruption[7818]: tohru eruption[7818]: Could not initialize the device: Device not opened
Jun 30 22:41:54 tohru eruption[7818]: tohru eruption[7818]: Step 1: Invalid result
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Keyboard device went away: No such device (os error 19)
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Error sending LED map to a device: Invalid result
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [3]
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Trying to unplug the failed device
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [2]
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: An error occurred while closing the device
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [3]
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Skipping uninitialized device, trying to re-initialize it now...
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [2]
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Error opening the keyboard device: Could not open the device file
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [2]
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: Could not initialize the device: Device not opened
Jun 30 22:43:45 tohru eruption[7818]: tohru eruption[7818]: The previous message was rate-limited [2]
Jun 30 22:45:17 tohru systemd[1]: Stopping Realtime RGB LED Driver for Linux...
Jun 30 22:45:18 tohru systemd[1]: eruption.service: Deactivated successfully.
Jun 30 22:45:18 tohru systemd[1]: Stopped Realtime RGB LED Driver for Linux.
Jun 30 22:45:18 tohru systemd[1]: eruption.service: Consumed 5h 47min 44.603s CPU time.
Jun 30 22:45:18 tohru systemd[1]: Starting Realtime RGB LED Driver for Linux...
Jun 30 22:45:18 tohru systemd[1]: Started Realtime RGB LED Driver for Linux.
Jun 30 22:45:18 tohru eruption[3791546]: tohru eruption[3791546]: ** EXPERIMENTAL DRIVERS are ENABLED, this may expose serious bugs! **
Jun 30 22:45:20 tohru eruption[3791546]: tohru eruption[3791546]: Step 1: Invalid result
Bus 004 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 003 Device 005: ID 046d:082d Logitech, Inc. HD Pro Webcam C920
Bus 003 Device 004: ID 1058:111d Western Digital Technologies, Inc. My Book 111D
Bus 003 Device 006: ID 046d:0a89 Logitech, Inc. G635 Gaming Headset
Bus 003 Device 002: ID 1a40:0101 Terminus Technology Inc. Hub
Bus 003 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 001 Device 018: ID 07ca:1513 AVerMedia Technologies, Inc. Live Gamer Portable 2 Plus
Bus 001 Device 016: ID 1397:0507 BEHRINGER International GmbH UMC202HD 192k
Bus 001 Device 019: ID 1e7d:3098 ROCCAT ROCCAT Vulcan AIMO
Bus 001 Device 013: ID 1e7d:2e2c ROCCAT ROCCAT Kone Aimo 16K
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub