-- Logs begin at Fri 2025-12-05 16:57:36 EET, end at Tue 2025-12-09 15:50:08 EET. --
Dec 09 15:49:11 volumio go-librespot[4155]: time="2025-12-09T15:49:11+02:00" level=debug msg="fetched chunk 7/9, size: 524288" uri="spotify:track:05xziK0DYtOhlpt9598dyw"
Dec 09 15:49:21 volumio sudo[4667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 09 15:49:21 volumio sudo[4667]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 09 15:49:21 volumio sudo[4667]: pam_unix(sudo:session): session closed for user root
Dec 09 15:49:21 volumio sudo[4670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 09 15:49:21 volumio sudo[4670]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 09 15:49:21 volumio sudo[4670]: pam_unix(sudo:session): session closed for user root
Dec 09 15:49:21 volumio volumio[3919]: verbose: New Socket.io Connection to 192.168.2.236 from 192.168.2.122 UA: Mozilla/5.0 (X11; Linux x86_64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 6
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::volumioGetState
Dec 09 15:49:22 volumio volumio[3919]: info: CorePlayQueue::getTrack 0
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 09 15:49:22 volumio volumio[3919]: info: Received Get System Info
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 09 15:49:22 volumio volumio[3919]: info: Discovery: Getting this device information
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::volumioGetState
Dec 09 15:49:22 volumio volumio[3919]: info: CorePlayQueue::getTrack 0
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::volumioGetState
Dec 09 15:49:22 volumio volumio[3919]: info: CorePlayQueue::getTrack 0
Dec 09 15:49:22 volumio volumio[3919]: info: Listing playlists
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 09 15:49:22 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Dec 09 15:49:23 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Dec 09 15:49:23 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 09 15:49:23 volumio volumio[3919]: info: Received Get System Info
Dec 09 15:49:23 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 09 15:49:23 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 09 15:49:23 volumio volumio[3919]: info: Discovery: Getting this device information
Dec 09 15:49:23 volumio volumio[3919]: info: CoreCommandRouter::volumioGetState
Dec 09 15:49:23 volumio volumio[3919]: info: CorePlayQueue::getTrack 0
Dec 09 15:49:23 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 09 15:49:23 volumio systemd[1]: Reloading.
Dec 09 15:49:24 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Dec 09 15:49:24 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 09 15:49:24 volumio volumio[3919]: info: Received Get System Info
Dec 09 15:49:24 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 09 15:49:24 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 09 15:49:24 volumio volumio[3919]: info: Discovery: Getting this device information
Dec 09 15:49:24 volumio volumio[3919]: info: CoreCommandRouter::volumioGetState
Dec 09 15:49:24 volumio volumio[3919]: info: CorePlayQueue::getTrack 0
Dec 09 15:49:24 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 09 15:49:24 volumio go-librespot[4155]: time="2025-12-09T15:49:24+02:00" level=debug msg="fetched chunk 8/9, size: 524288" uri="spotify:track:05xziK0DYtOhlpt9598dyw"
Dec 09 15:49:25 volumio volumio[3919]: info: Removing dependencies
Dec 09 15:49:25 volumio volumio[3919]: info: Reading package lists...
Dec 09 15:49:25 volumio volumio[3919]: info: Building dependency tree...
Dec 09 15:49:25 volumio volumio[3919]: info: Reading state information...
Dec 09 15:49:25 volumio volumio[3919]: info: Package 'fonts-arphic-ukai' is not installed, so not removed
Dec 09 15:49:25 volumio volumio[3919]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded.
Dec 09 15:49:25 volumio volumio[3919]: info: Reading package lists...
Dec 09 15:49:25 volumio volumio[3919]: info: Building dependency tree...
Dec 09 15:49:25 volumio volumio[3919]: info: Reading state information...
Dec 09 15:49:25 volumio volumio[3919]: info: Package 'fonts-arphic-gbsn00lp' is not installed, so not removed
Dec 09 15:49:25 volumio volumio[3919]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded.
Dec 09 15:49:25 volumio volumio[3919]: info: Reading package lists...
Dec 09 15:49:25 volumio volumio[3919]: info: Building dependency tree...
Dec 09 15:49:25 volumio volumio[3919]: info: Reading state information...
Dec 09 15:49:25 volumio volumio[3919]: info: Package 'fonts-unfonts-core' is not installed, so not removed
Dec 09 15:49:25 volumio volumio[3919]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded.
Dec 09 15:49:25 volumio volumio[3919]: info: Reading package lists...
Dec 09 15:49:25 volumio volumio[3919]: info: Building dependency tree...
Dec 09 15:49:25 volumio volumio[3919]: info: Reading state information...
Dec 09 15:49:25 volumio volumio[3919]: info: Package 'fonts-ipafont' is not installed, so not removed
Dec 09 15:49:25 volumio volumio[3919]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded.
Dec 09 15:49:25 volumio volumio[3919]: info: Reading package lists...
Dec 09 15:49:25 volumio volumio[3919]: info: Building dependency tree...
Dec 09 15:49:25 volumio volumio[3919]: info: Reading state information...
Dec 09 15:49:25 volumio volumio[3919]: info: Package 'fonts-vlgothic' is not installed, so not removed
Dec 09 15:49:25 volumio volumio[3919]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded.
Dec 09 15:49:25 volumio volumio[3919]: info: Reading package lists...
Dec 09 15:49:25 volumio volumio[3919]: info: Building dependency tree...
Dec 09 15:49:25 volumio volumio[3919]: info: Reading state information...
Dec 09 15:49:25 volumio volumio[3919]: info: Package 'fonts-thai-tlwg-ttf' is not installed, so not removed
Dec 09 15:49:25 volumio volumio[3919]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded.
Dec 09 15:49:25 volumio volumio[3919]: info: Reading package lists...
Dec 09 15:49:25 volumio volumio[3919]: info: Building dependency tree...
Dec 09 15:49:25 volumio volumio[3919]: info: Reading state information...
Dec 09 15:49:25 volumio volumio[3919]: info: Package 'chromium-browser' is not installed, so not removed
Dec 09 15:49:25 volumio volumio[3919]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded.
Dec 09 15:49:25 volumio volumio[3919]: info: Reading package lists...
Dec 09 15:49:25 volumio volumio[3919]: info: Building dependency tree...
Dec 09 15:49:25 volumio volumio[3919]: info: Reading state information...
Dec 09 15:49:25 volumio volumio[3919]: info: Package 'openbox' is not installed, so not removed
Dec 09 15:49:25 volumio volumio[3919]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded.
Dec 09 15:49:25 volumio volumio[3919]: info: Reading package lists...
Dec 09 15:49:25 volumio volumio[3919]: info: Building dependency tree...
Dec 09 15:49:25 volumio volumio[3919]: info: Reading state information...
Dec 09 15:49:25 volumio volumio[3919]: info: Package 'xinit' is not installed, so not removed
Dec 09 15:49:25 volumio volumio[3919]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded.
Dec 09 15:49:25 volumio volumio[3919]: info: Deleting /opt/volumiokiosk.sh
Dec 09 15:49:25 volumio volumio[3919]: info: Deleting /data/volumiokiosk
Dec 09 15:49:25 volumio volumio[3919]: info: Deleting /data/volumiokioskextensions
Dec 09 15:49:25 volumio volumio[3919]: info: Deleting /lib/systemd/system/volumio-kiosk.service
Dec 09 15:49:25 volumio volumio[3919]: info: Enabling login prompt
Dec 09 15:49:25 volumio volumio[3919]: info: Done
Dec 09 15:49:25 volumio sudo[4362]: pam_unix(sudo:session): session closed for user root
Dec 09 15:49:26 volumio volumio[3919]: info: Install script return the error Error: Command failed: echo volumio | sudo -S sh /data/plugins/user_interface/touch_display/install.sh > /tmp/installog
Dec 09 15:49:26 volumio volumio[3919]: [sudo] password for volumio: E: The repository 'http://raspbian.raspberrypi.org/raspbian buster Release' no longer has a Release file.
Dec 09 15:49:26 volumio volumio[3919]: rm: cannot remove '/opt/volumiokiosk.sh': No such file or directory
Dec 09 15:49:26 volumio volumio[3919]: rm: cannot remove '/lib/systemd/system/volumio-kiosk.service': No such file or directory
Dec 09 15:49:26 volumio volumio[3919]: info: An error occurred installing the plugin. Rolling back config
Dec 09 15:49:26 volumio volumio[3919]: info: Plugin folders cleanup
Dec 09 15:49:26 volumio volumio[3919]: info: Scanning into folder /volumio/app/plugins/
Dec 09 15:49:26 volumio volumio[3919]: info: Scanning category audio_interface
Dec 09 15:49:26 volumio volumio[3919]: info: Scanning category miscellanea
Dec 09 15:49:26 volumio volumio[3919]: info: Scanning category music_service
Dec 09 15:49:26 volumio volumio[3919]: info: Scanning category plugins.json
Dec 09 15:49:26 volumio volumio[3919]: info: Scanning category system_controller
Dec 09 15:49:26 volumio volumio[3919]: info: Scanning category user_interface
Dec 09 15:49:26 volumio volumio[3919]: info: Scanning into folder /data/plugins/
Dec 09 15:49:26 volumio volumio[3919]: info: Scanning category music_service
Dec 09 15:49:26 volumio volumio[3919]: info: Scanning category system_controller
Dec 09 15:49:26 volumio volumio[3919]: info: Scanning category user_interface
Dec 09 15:49:26 volumio volumio[3919]: info: Plugin folders cleanup completed
Dec 09 15:49:26 volumio volumio[3919]: info: Error: Error
Dec 09 15:49:26 volumio volumio[3919]: info: Removing plugin directory /data/plugins/user_interface/touch_display
Dec 09 15:49:26 volumio volumio[3919]: info: Folder /tmp/plugins removed
Dec 09 15:49:26 volumio volumio[3919]: info: Folder /tmp/downloaded_plugin.zip removed
Dec 09 15:49:26 volumio volumio[3919]: info: Folder /data/temp removed
Dec 09 15:49:26 volumio volumio[3919]: info: Removing temporary directory /tmp/touch_display-4EOJRguj6M
Dec 09 15:49:26 volumio volumio[3919]: Plugin install end detected on script
Dec 09 15:49:26 volumio go-librespot[4155]: time="2025-12-09T15:49:26+02:00" level=trace msg="sent dealer ping"
Dec 09 15:49:26 volumio go-librespot[4155]: time="2025-12-09T15:49:26+02:00" level=trace msg="received dealer pong"
Dec 09 15:49:31 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Dec 09 15:49:37 volumio volumio[3919]: info: Starting Uninstall of plugin user_interface - touch_display
Dec 09 15:49:38 volumio go-librespot[4155]: time="2025-12-09T15:49:38+02:00" level=debug msg="fetched chunk 9/9, size: 220056" uri="spotify:track:05xziK0DYtOhlpt9598dyw"
Dec 09 15:49:40 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 09 15:49:40 volumio volumio[3919]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Dec 09 15:49:40 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Dec 09 15:49:40 volumio volumio[3919]: info: Received Get System Version
Dec 09 15:49:40 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 09 15:49:40 volumio volumio[3919]: info: Received Get System Info
Dec 09 15:49:40 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 09 15:49:40 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 09 15:49:40 volumio volumio[3919]: info: Discovery: Getting this device information
Dec 09 15:49:40 volumio volumio[3919]: info: CoreCommandRouter::volumioGetState
Dec 09 15:49:40 volumio volumio[3919]: info: CorePlayQueue::getTrack 0
Dec 09 15:49:40 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 09 15:49:49 volumio volumio[3919]: info: CoreCommandRouter::volumioGetState
Dec 09 15:49:49 volumio volumio[3919]: info: CorePlayQueue::getTrack 0
Dec 09 15:49:54 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 09 15:49:54 volumio volumio[3919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 09 15:49:56 volumio go-librespot[4155]: time="2025-12-09T15:49:56+02:00" level=trace msg="received accesspoint ping"
Dec 09 15:49:56 volumio go-librespot[4155]: time="2025-12-09T15:49:56+02:00" level=trace msg="received accesspoint pong ack"
Dec 09 15:49:56 volumio go-librespot[4155]: time="2025-12-09T15:49:56+02:00" level=trace msg="sent dealer ping"
Dec 09 15:49:56 volumio go-librespot[4155]: time="2025-12-09T15:49:56+02:00" level=trace msg="received dealer pong"
Dec 09 15:50:03 volumio volumio[3919]: info: [ASDebug] Port: 24
Dec 09 15:50:03 volumio volumio[3919]: info: [ASDebug] Inverted: false
Dec 09 15:50:03 volumio volumio[3919]: info: [ASDebug] Delay: 30
Dec 09 15:50:07 volumio volumio[3919]: info: Starting Uninstall of plugin system_controller - ampswitch
Dec 09 15:50:07 volumio volumio[3919]: info: Uninstalling plugin ampswitch
Dec 09 15:50:07 volumio volumio[3919]: info: [ASDebug] Port: 24
Dec 09 15:50:07 volumio volumio[3919]: info: [ASDebug] Inverted: false
Dec 09 15:50:07 volumio volumio[3919]: info: [ASDebug] Delay: 30
Dec 09 15:50:07 volumio volumio[3919]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 09 15:50:07 volumio volumio[3919]: Error: EBADF: bad file descriptor, close
Dec 09 15:50:07 volumio volumio[3919]: at Object.closeSync (fs.js:439:3)
Dec 09 15:50:07 volumio volumio[3919]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20)
Dec 09 15:50:07 volumio volumio[3919]: at Object.closeSync (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27)
Dec 09 15:50:07 volumio volumio[3919]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8)
Dec 09 15:50:07 volumio volumio[3919]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19)
Dec 09 15:50:07 volumio volumio[3919]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10)
Dec 09 15:50:07 volumio volumio[3919]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Dec 09 15:50:07 volumio volumio[3919]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10)
Dec 09 15:50:07 volumio volumio[3919]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1484:22)
Dec 09 15:50:07 volumio volumio[3919]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1271:45)
Dec 09 15:50:07 volumio volumio[3919]: at Socket.emit (events.js:315:20)
Dec 09 15:50:07 volumio volumio[3919]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Dec 09 15:50:07 volumio volumio[3919]: at processTicksAndRejections (internal/process/task_queues.js:75:11) {
Dec 09 15:50:07 volumio volumio[3919]: errno: -9,
Dec 09 15:50:07 volumio volumio[3919]: syscall: 'close',
Dec 09 15:50:07 volumio volumio[3919]: code: 'EBADF'
Dec 09 15:50:07 volumio volumio[3919]: }
Dec 09 15:50:07 volumio volumio[3919]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 09 15:50:08 volumio sudo[4820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-09 15:49
Dec 09 15:50:08 volumio sudo[4820]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="cc50ad4a2058d01de272214eb33827883bd2b7d8"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET"
VOLUMIO_VERSION="3.874"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"