🐛 | RFID service won't start

[Momro]

Version

2.8.0 - 5044358 - master

Branch

master

OS

RPi 64bit lite

Pi model

Zero 2W

Hardware

RC522 reader

What happened?

I am trying to run RegisterDevice.py, but it fails

Logs

$ journalctl -n 200 | catcat
Mar 30 22:31:24 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 15.
Mar 30 22:31:24 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:31:24 phoniebox (coder.py)[1622]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:31:24 phoniebox (coder.py)[1622]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:31:24 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:31:24 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:31:24 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:31:28 phoniebox sudo[1624]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/atq -q s
Mar 30 22:31:28 phoniebox sudo[1624]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:31:28 phoniebox sudo[1624]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:28 phoniebox sudo[1628]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/atq -q t
Mar 30 22:31:28 phoniebox sudo[1628]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:31:28 phoniebox sudo[1628]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:28 phoniebox sudo[1632]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/atq -q q
Mar 30 22:31:28 phoniebox sudo[1632]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:31:28 phoniebox sudo[1632]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:28 phoniebox kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211
Mar 30 22:31:28 phoniebox sudo[1640]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/bash -c 'source /home/pi/RPi-Jukebox-RFID/scripts/helperscripts/inc.networkHelper.sh && get_wireless_networks'
Mar 30 22:31:28 phoniebox sudo[1640]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:31:29 phoniebox sudo[1659]:     root : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/nmcli --show-secrets -t -f 802-11-wireless.ssid,802-11-wireless-security.psk,connection.autoconnect-priority con show bb99eb15-0eb4-4007-a4e9-c73529965510
Mar 30 22:31:29 phoniebox sudo[1659]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Mar 30 22:31:29 phoniebox sudo[1659]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:29 phoniebox sudo[1640]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:30 phoniebox sudo[1683]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs/api ; USER=root ; COMMAND=/usr/bin/echo playlistinfo#012close
Mar 30 22:31:30 phoniebox sudo[1683]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:31:30 phoniebox sudo[1683]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:34 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 16.
Mar 30 22:31:34 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:31:34 phoniebox (coder.py)[1686]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:31:34 phoniebox (coder.py)[1686]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:31:34 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:31:34 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:31:34 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:31:38 phoniebox sudo[1704]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/vcgencmd measure_temp
Mar 30 22:31:38 phoniebox sudo[1704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:31:38 phoniebox sudo[1704]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:38 phoniebox sudo[1707]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/vcgencmd get_throttled
Mar 30 22:31:38 phoniebox sudo[1707]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:31:38 phoniebox sudo[1707]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:38 phoniebox sudo[1717]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/home/pi/RPi-Jukebox-RFID/scripts/inc.writeGlobalConfig.sh
Mar 30 22:31:38 phoniebox sudo[1717]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:31:38 phoniebox sudo[1802]:     root : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/chown -R pi:www-data /home/pi/RPi-Jukebox-RFID/scripts/../settings/global.conf
Mar 30 22:31:38 phoniebox sudo[1802]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Mar 30 22:31:38 phoniebox sudo[1802]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:38 phoniebox sudo[1804]:     root : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/chmod -R 777 /home/pi/RPi-Jukebox-RFID/scripts/../settings/global.conf
Mar 30 22:31:38 phoniebox sudo[1804]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Mar 30 22:31:38 phoniebox sudo[1804]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:38 phoniebox sudo[1717]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:38 phoniebox sudo[1807]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/chmod 777 /home/pi/RPi-Jukebox-RFID/settings/global.conf
Mar 30 22:31:38 phoniebox sudo[1807]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:31:38 phoniebox sudo[1807]: pam_unix(sudo:session): session closed for user root
Mar 30 22:31:39 phoniebox lighttpd[1814]: tail: cannot open '../logs/debug.log' for reading: No such file or directory
Mar 30 22:31:44 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 17.
Mar 30 22:31:44 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:31:44 phoniebox (coder.py)[1823]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:31:44 phoniebox (coder.py)[1823]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:31:44 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:31:44 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:31:44 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:31:54 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 18.
Mar 30 22:31:54 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:31:55 phoniebox (coder.py)[1832]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:31:55 phoniebox (coder.py)[1832]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:31:55 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:31:55 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:31:55 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:32:05 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 19.
Mar 30 22:32:05 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:05 phoniebox (coder.py)[1841]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:05 phoniebox (coder.py)[1841]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:05 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:05 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:32:05 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:32:15 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 20.
Mar 30 22:32:15 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:15 phoniebox (coder.py)[1874]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:15 phoniebox (coder.py)[1874]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:15 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:15 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:32:15 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:32:25 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 21.
Mar 30 22:32:25 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:25 phoniebox (coder.py)[1883]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:25 phoniebox (coder.py)[1883]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:25 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:25 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:32:25 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:32:35 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 22.
Mar 30 22:32:35 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:36 phoniebox (coder.py)[1892]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:36 phoniebox (coder.py)[1892]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:36 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:36 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:32:36 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:32:46 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 23.
Mar 30 22:32:46 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:46 phoniebox (coder.py)[1901]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:46 phoniebox (coder.py)[1901]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:46 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:46 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:32:46 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:32:56 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 24.
Mar 30 22:32:56 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:56 phoniebox (coder.py)[1910]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:56 phoniebox (coder.py)[1910]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:32:56 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:32:56 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:32:56 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:33:06 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 25.
Mar 30 22:33:06 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:06 phoniebox (coder.py)[1921]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:06 phoniebox (coder.py)[1921]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:06 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:06 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:33:06 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:33:16 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 26.
Mar 30 22:33:16 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:17 phoniebox (coder.py)[1932]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:17 phoniebox (coder.py)[1932]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:17 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:17 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:33:17 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:33:27 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 27.
Mar 30 22:33:27 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:27 phoniebox (coder.py)[1968]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:27 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:27 phoniebox (coder.py)[1968]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:27 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:33:27 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:33:37 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 28.
Mar 30 22:33:37 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:37 phoniebox (coder.py)[1992]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:37 phoniebox (coder.py)[1992]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:37 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:37 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:33:37 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:33:47 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 29.
Mar 30 22:33:47 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:47 phoniebox (coder.py)[2003]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:47 phoniebox (coder.py)[2003]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:47 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:47 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:33:47 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:33:54 phoniebox NetworkManager[485]: <info>  [1743366834.9742] dhcp4 (wlan0): state changed new lease, address=192.168.6.6
Mar 30 22:33:57 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 30.
Mar 30 22:33:57 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:58 phoniebox (coder.py)[2014]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:58 phoniebox (coder.py)[2014]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:33:58 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:33:58 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:33:58 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.
Mar 30 22:34:00 phoniebox sudo[2021]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/atq -q s
Mar 30 22:34:00 phoniebox sudo[2021]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:34:00 phoniebox sudo[2021]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:00 phoniebox sudo[2025]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/atq -q t
Mar 30 22:34:00 phoniebox sudo[2025]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:34:00 phoniebox sudo[2025]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:00 phoniebox sudo[2029]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/atq -q q
Mar 30 22:34:00 phoniebox sudo[2029]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:34:00 phoniebox sudo[2029]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:00 phoniebox sudo[2037]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/bash -c 'source /home/pi/RPi-Jukebox-RFID/scripts/helperscripts/inc.networkHelper.sh && get_wireless_networks'
Mar 30 22:34:00 phoniebox sudo[2037]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:34:00 phoniebox sudo[2056]:     root : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/nmcli --show-secrets -t -f 802-11-wireless.ssid,802-11-wireless-security.psk,connection.autoconnect-priority con show bb99eb15-0eb4-4007-a4e9-c73529965510
Mar 30 22:34:00 phoniebox sudo[2056]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Mar 30 22:34:00 phoniebox sudo[2056]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:00 phoniebox sudo[2037]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:00 phoniebox sudo[2081]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs/api ; USER=root ; COMMAND=/usr/bin/echo playlistinfo#012close
Mar 30 22:34:00 phoniebox sudo[2081]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:34:00 phoniebox sudo[2081]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:03 phoniebox sudo[2085]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/bin/systemctl stop phoniebox-gpio-control.service
Mar 30 22:34:03 phoniebox sudo[2085]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:34:03 phoniebox systemd[1]: Stopping phoniebox-gpio-control.service - Phoniebox GPIO Control Service...
Mar 30 22:34:03 phoniebox systemd[1]: phoniebox-gpio-control.service: Deactivated successfully.
Mar 30 22:34:03 phoniebox systemd[1]: Stopped phoniebox-gpio-control.service - Phoniebox GPIO Control Service.
Mar 30 22:34:03 phoniebox sudo[2085]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:03 phoniebox sudo[2088]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/atq -q s
Mar 30 22:34:03 phoniebox sudo[2088]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:34:03 phoniebox sudo[2088]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:03 phoniebox sudo[2092]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/atq -q t
Mar 30 22:34:03 phoniebox sudo[2092]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:34:03 phoniebox sudo[2092]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:03 phoniebox sudo[2096]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/atq -q q
Mar 30 22:34:03 phoniebox sudo[2096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:34:03 phoniebox sudo[2096]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:03 phoniebox sudo[2104]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/bash -c 'source /home/pi/RPi-Jukebox-RFID/scripts/helperscripts/inc.networkHelper.sh && get_wireless_networks'
Mar 30 22:34:03 phoniebox sudo[2104]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:34:03 phoniebox sudo[2123]:     root : PWD=/home/pi/RPi-Jukebox-RFID/htdocs ; USER=root ; COMMAND=/usr/bin/nmcli --show-secrets -t -f 802-11-wireless.ssid,802-11-wireless-security.psk,connection.autoconnect-priority con show bb99eb15-0eb4-4007-a4e9-c73529965510
Mar 30 22:34:03 phoniebox sudo[2123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Mar 30 22:34:03 phoniebox sudo[2123]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:03 phoniebox sudo[2104]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:04 phoniebox sudo[2147]: www-data : PWD=/home/pi/RPi-Jukebox-RFID/htdocs/api ; USER=root ; COMMAND=/usr/bin/echo playlistinfo#012close
Mar 30 22:34:04 phoniebox sudo[2147]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=33)
Mar 30 22:34:04 phoniebox sudo[2147]: pam_unix(sudo:session): session closed for user root
Mar 30 22:34:08 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Scheduled restart job, restart counter is at 31.
Mar 30 22:34:08 phoniebox systemd[1]: Stopped phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:34:08 phoniebox (coder.py)[2150]: phoniebox-buttons-usb-encoder.service: Failed to locate executable /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:34:08 phoniebox (coder.py)[2150]: phoniebox-buttons-usb-encoder.service: Failed at step EXEC spawning /home/pi/RPi-Jukebox-RFID/components/controls/buttons_usb_encoder/buttons_usb_encoder.py: Permission denied
Mar 30 22:34:08 phoniebox systemd[1]: Started phoniebox-buttons-usb-encoder.service - Phoniebox Buttons USB Encoder Service.
Mar 30 22:34:08 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Main process exited, code=exited, status=203/EXEC
Mar 30 22:34:08 phoniebox systemd[1]: phoniebox-buttons-usb-encoder.service: Failed with result 'exit-code'.

Configuration

I don't think there is a relevant config for the RFID reader. SPI is enabled according to raspi-config.

More info

• The reader is working. I tested it on a different Pi with a simple script and could read several RFID cards
• Fresh install of OS, no other software installed (Vim and ZSH)
• everything up to date (apt update && apt upgrade && apt dist-upgrade && rpi-update
• I installed all required python packages according to https://github.com/MiczFlor/RPi-Jukebox-RFID/blob/develop/components/rfid-reader/RC522/README.md
• moving Reader.py to Reader.py.experimental did not improve anything (ln -s Reader.py Reader.py.experimental). I get the following error when I try to choose my reader from the list:

$ python3 RegisterDevice.py
Choose the reader from list
0 vc4-hdmi HDMI Jack
1 vc4-hdmi
2 MFRC522
3 RDM6300
4 PN532
Device Number: 2
Traceback (most recent call last):
  File "/home/pi/RPi-Jukebox-RFID/scripts/RegisterDevice.py", line 21, in <module>
    dev.close()
    ^^^^^^^^^
AttributeError: 'NonUsbDevice' object has no attribute 'close'

[Momro]

I ordered the Neuftech USB reader and that one does not work either. Same error message:

# python3 RegisterDevice.py
Choose the reader from list
0 vc4-hdmi HDMI Jack
1 vc4-hdmi
2 CM109 USB driver
3 MFRC522
4 RDM6300
5 PN532
Device Number: 2
Traceback (most recent call last):
  File "/home/pi/RPi-Jukebox-RFID/scripts/RegisterDevice.py", line 21, in <module>
    dev.close()
    ^^^^^^^^^
AttributeError: 'NonUsbDevice' object has no attribute 'close'

Neither with Reader.py nor Reader.py.experimental would it work.

I mean, when you look at the code in Reader.py, it is obvious that the class does not have the function close. This dev.close() was added by @s-martin 2023-03-12:

# git blame RegisterDevice.py | grep "dev.close" -B 1
3bebe5991 (s-martin   2023-03-12 13:58:48 +0100 20) for dev in devices:
3bebe5991 (s-martin   2023-03-12 13:58:48 +0100 21)     dev.close()

I wonder why it ever worked for anyone for the past 2 years :-/ There is no definition of that close function in the scripts folder:

╭─[19:37] [pi@phoniebox] git:(master) ✗ ~/RPi-Jukebox-RFID/scripts
# grep "close" Reader.py
        self.rfid_serial.close()
╭─[19:37] [pi@phoniebox] git:(master) ✗ ~/RPi-Jukebox-RFID/scripts
# grep "close" Reader.py.experimental
        self.rfid_serial.close()

I commented line 21 out (dev.close()), now I can in fact add the Neuftech and the service will start, but I cannot read any tags, but I'm not sure if it is due to the Neuftech or the cards. I have a RFID card with hello world saved on it. My mobile phone will display that, but nothing happens in the Neuftech. It could by that the card is not compatible though. Amazon delivered 5 RFID tags alongside the USB device, and none of the work either on the Reader or my mobile phone.

I tested a different tag that came with my door bell, and it neither works with my phone nor with the Neuftech reader in Phoniebox.

[willemOH]

Wow I was losing it over here with reinstalls trying to get my PN532 (different than the two you tried, im reading) to register cards and show the latest id in the web app. Commenting out dev.close() in RegisterDevice.py and then restarting the service as the readme instructs - RPi-Jukebox-RFID\components\rfid-reader\PN532\Readme.md actually worked. now I can see the id updating in the web app when I swipe a tag. Whats misleading is if you search my chip reader online you will get a thread that verifies this works "out of the box" so clearly some thing(s) have been broken since then. Now to address mpd not being able to configure 🙄

[Momro]

Happy it works for you, mate :-)
If I was still working on the Phoniebox, I'd order a PN532, but I swapped to "Tonuino" and am about to finish the project ... hopefully ... but might return some time to Phoniebox. I like the Wifi idea ...

[Coernel82]

I have the same problem, however I already made one big mistake. As the release says:

Caution

Do NOT use the latest RaspberryPi OS Bookworm release (also don't upgrade via apt) with the new kernel 6.6, if you need to use GPIO components . There have been incompatible changes for the RPi.GPIO library, so Shims and Rfid Reader usage can be broken (#2295).

Using RaspberryPi OS Bullseye is the current recommendation as it does not use the new kernel.

I am reinstalling with an old Pi OS and report back...

[Coernel82]

Reporting back now: Install the legacy Pi OS and it will work...

[willemOH]

@Coernel82 did you use the 32-bit or 64-bit? I'm using 32-bit bullseye lite on Rpi 3B+ and I had to do this fixing stuff. What rfid reader are you using? I'm using the waveshare pn532 (with the pins set to i2c).

I still haven't got this quite working. Although the tag is detected in the webapp and I got the audio to work, touching the tag to the reader won't actually play the file yet. I can select play and pause of songs from the web app and that works. But theres some missing command to actually link the rfid card detection with the playing of the folder of audio files.

[willemOH]

To follow up I did get everything basic working. I don't know if it was related to the rfid tag reader setup being broken but, as I said, mpc didn't get initialized right (there was an error about it during installation, each of the three times I installed). So I had to reinstall that, get audio output working, change where mpc thought my music files were to the phoniebox locations (in etc/mpd.conf) and finally grant some permissions

sudo chown pi:www-data /home/pi/RPi-Jukebox-RFID/settings/Latest_Folder_Played
sudo chmod 777 /home/pi/RPi-Jukebox-RFID/settings/Latest_Folder_Played

sudo chown pi:www-data /home/pi/RPi-Jukebox-RFID/settings/Latest_Playlist_Played
sudo chmod 777 /home/pi/RPi-Jukebox-RFID/settings/Latest_Playlist_Played

The only thing that got me after this was that rfid tags that are assigned to functions wont work if they are assigned to multiple functions (so either go into /home/pi/RPi-Jukebox-RFID/settings/commands.conf and delete/rename them or assign one of the functions to a different tag). I don't know if theres a bug on mine after all this guts-shifting that causes tags to not be removed from other functions automatically or if thats just how the thing is (error-pronely) designed. But I seem to have the basics working after way more engineering that I had hope would be involved. Hopefully I have no more need for features (maybe gpio in future hopefully will work nothing touched - ha!)

I pray this does not happen to anyone else and that I am just a lightning rod for technical malfunction protecting the rest of you from spirals of madness :)

[Coernel82]

I installed the Raspian OS Lite legacy version - 64 bit. Then I ran the one line install script and it worked. I use the RC522 reader. I had nothing to do to make it work! The device is a Raspberry Pi 3B.

I can open streams from my NAS, Spotify and play local files.

[Momro]

I wonder why they did not include a small script in the install process that checks for the current OS, and halts if it is the wrong version.

Very little effort, huge effect

[s-martin]

PRs are always welcome 🤗

[Momro]

The repository says I have to be a contributor. I skimmed over the documentation and found nothing on how to become one.

I added this code to the installer script and it works on my Pi Zero with Bookworm installed, see example execution below:

# cat install-jukebox.sh | grep checkPre -A 10
checkPrerequisite() {
        # Currently, RPi OS Bookworm is not supported, see https://github.com/MiczFlor/RPi-Jukebox-RFID/wiki/INSTALL#installing-phoniebox
        # Exit installer if Bookworm is installed
        if [[ $(cat /etc/os-release | grep "VERSION_CODENAME=bookworm" ) != '' ]] ; then
                echo "[ERROR] You are using RPi OS Bookworm. This is not supported by Phoniebox, see install instructions"
                echo "Exit"
                exit 2
        fi

    #currently the user 'pi' is mandatory
    #https://github.com/MiczFlor/RPi-Jukebox-RFID/issues/1785

# cat /etc/os-release                                                                                                                                                                      PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"

# ./install-jukebox.sh
[ERROR] You are using RPi OS Bookworm. This is not supported by Phoniebox, see install instructions
Exit