-- Logs begin at Thu 2025-05-01 16:15:17 CEST, end at Tue 2025-06-24 19:21:08 CEST. -- Jun 24 19:20:03 volumio node[5610]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 24 19:20:03 volumio node[5610]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 24 19:20:03 volumio node[5610]: *** WARNING *** For more information see Jun 24 19:20:03 volumio node[5610]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 24 19:20:03 volumio node[5610]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 24 19:20:03 volumio node[5610]: *** WARNING *** For more information see Jun 24 19:20:10 volumio wpa_supplicant[730]: wlan0: WPA: Group rekeying completed with 3c:84:6a:71:e1:b2 [GTK=TKIP] Jun 24 19:20:17 volumio sudo[5659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jun 24 19:20:17 volumio sudo[5659]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 19:20:17 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 24 19:20:17 volumio sudo[5659]: pam_unix(sudo:session): session closed for user root Jun 24 19:20:20 volumio sudo[5669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 24 19:20:20 volumio sudo[5669]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 19:20:20 volumio systemd[1]: Stopping Volumio Streaming Daemon... Jun 24 19:20:20 volumio systemd[1]: Starting Volumio Streaming Daemon... Jun 24 19:20:20 volumio systemd[1]: Started Volumio Streaming Daemon. Jun 24 19:20:20 volumio sudo[5669]: pam_unix(sudo:session): session closed for user root Jun 24 19:20:20 volumio volumio-streaming-daemon[5675]: ############################ Jun 24 19:20:20 volumio volumio-streaming-daemon[5675]: # Volumio Streaming Daemon # Jun 24 19:20:20 volumio volumio-streaming-daemon[5675]: # Running on port 7777 # Jun 24 19:20:20 volumio volumio-streaming-daemon[5675]: ############################ Jun 24 19:20:21 volumio sudo[5695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 24 19:20:21 volumio sudo[5695]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 19:20:21 volumio sudo[5695]: pam_unix(sudo:session): session closed for user root Jun 24 19:20:25 volumio sudo[5711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-24 19:19 Jun 24 19:20:25 volumio sudo[5711]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 19:20:25 volumio sudo[5711]: pam_unix(sudo:session): session closed for user root Jun 24 19:20:26 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Jun 24 19:20:26 volumio systemd[1]: Unit volumio.service entered failed state. Jun 24 19:20:26 volumio systemd[1]: Starting dynamicswap service... Jun 24 19:20:26 volumio systemd[1]: Started dynamicswap service. Jun 24 19:20:26 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Jun 24 19:20:26 volumio systemd[1]: Starting dynamicswap service... Jun 24 19:20:26 volumio systemd[1]: Started dynamicswap service. Jun 24 19:20:26 volumio systemd[1]: Stopping Volumio Backend Module... Jun 24 19:20:26 volumio systemd[1]: Starting Volumio Backend Module... Jun 24 19:20:26 volumio systemd[1]: Started Volumio Backend Module. Jun 24 19:20:33 volumio volumio[5735]: info: ------------------------------------------- Jun 24 19:20:33 volumio volumio[5735]: info: ----- Volumio2 ---- Jun 24 19:20:33 volumio volumio[5735]: info: ------------------------------------------- Jun 24 19:20:33 volumio volumio[5735]: info: ----- System startup ---- Jun 24 19:20:33 volumio volumio[5735]: info: ------------------------------------------- Jun 24 19:20:33 volumio volumio[5735]: info: Plugin folders cleanup Jun 24 19:20:33 volumio volumio[5735]: info: Scanning into folder /volumio/app/plugins/ Jun 24 19:20:33 volumio volumio[5735]: info: Scanning category audio_interface Jun 24 19:20:33 volumio volumio[5735]: info: Scanning category miscellanea Jun 24 19:20:33 volumio volumio[5735]: info: Scanning category music_service Jun 24 19:20:33 volumio volumio[5735]: info: Scanning category plugins.json Jun 24 19:20:33 volumio volumio[5735]: info: Scanning category system_controller Jun 24 19:20:33 volumio volumio[5735]: info: Scanning category user_interface Jun 24 19:20:33 volumio volumio[5735]: info: Scanning into folder /data/plugins/ Jun 24 19:20:33 volumio volumio[5735]: info: Scanning category miscellanea Jun 24 19:20:33 volumio volumio[5735]: info: Scanning category music_service Jun 24 19:20:33 volumio volumio[5735]: info: Scanning category system_controller Jun 24 19:20:33 volumio volumio[5735]: info: Scanning category user_interface Jun 24 19:20:33 volumio volumio[5735]: info: Plugin folders cleanup completed Jun 24 19:20:33 volumio volumio[5735]: info: ------------------------------------------- Jun 24 19:20:33 volumio volumio[5735]: info: ----- Core plugins startup ---- Jun 24 19:20:33 volumio volumio[5735]: info: ------------------------------------------- Jun 24 19:20:33 volumio volumio[5735]: info: Loading plugins from folder /volumio/app/plugins/ Jun 24 19:20:33 volumio volumio[5735]: info: Adding plugin upnp to MyMusic Plugins Jun 24 19:20:33 volumio volumio[5735]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 24 19:20:33 volumio volumio[5735]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 24 19:20:33 volumio volumio[5735]: info: Loading plugins from folder /data/plugins/ Jun 24 19:20:33 volumio volumio[5735]: info: Loading plugin "system"... Jun 24 19:20:34 volumio volumio[5735]: { Error: ENOENT: no such file or directory, open '/sys/class/net/eth0/address' Jun 24 19:20:34 volumio volumio[5735]: at Object.fs.openSync (fs.js:646:18) Jun 24 19:20:34 volumio volumio[5735]: at Object.fs.readFileSync (fs.js:551:33) Jun 24 19:20:34 volumio volumio[5735]: at ControllerSystem.callHome (/volumio/app/plugins/system_controller/system/index.js:577:20) Jun 24 19:20:34 volumio volumio[5735]: at ControllerSystem.onVolumioStart (/volumio/app/plugins/system_controller/system/index.js:51:7) Jun 24 19:20:34 volumio volumio[5735]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:167:35) Jun 24 19:20:34 volumio volumio[5735]: at /volumio/app/pluginmanager.js:259:30 Jun 24 19:20:34 volumio volumio[5735]: at Array.forEach () Jun 24 19:20:34 volumio volumio[5735]: at HashMap. (/volumio/app/pluginmanager.js:258:17) Jun 24 19:20:34 volumio volumio[5735]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:172:10) Jun 24 19:20:34 volumio volumio[5735]: at HashMap.proto.(anonymous function) [as forEach] (/volumio/node_modules/hashmap/hashmap.js:184:7) Jun 24 19:20:34 volumio volumio[5735]: errno: -2, Jun 24 19:20:34 volumio volumio[5735]: code: 'ENOENT', Jun 24 19:20:34 volumio volumio[5735]: syscall: 'open', Jun 24 19:20:34 volumio volumio[5735]: path: '/sys/class/net/eth0/address' } Jun 24 19:20:34 volumio volumio[5735]: info: Plugin mpd_oled is not enabled Jun 24 19:20:34 volumio volumio[5735]: info: Loading plugin "appearance"... Jun 24 19:20:38 volumio volumio[5735]: info: Loading plugin "network"... Jun 24 19:20:39 volumio volumio[5735]: info: Loading plugin "services"... Jun 24 19:20:39 volumio volumio[5735]: info: Loading plugin "alsa_controller"... Jun 24 19:20:39 volumio volumio[5735]: info: Loading plugin "wizard"... Jun 24 19:20:39 volumio volumio[5735]: info: Loading plugin "volumio_command_line_client"... Jun 24 19:20:39 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:20:39 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:20:39 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:20:39 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:20:39 volumio volumio[5735]: info: Loading plugin "upnp"... Jun 24 19:20:39 volumio volumio[5735]: info: [1750785639749] Starting Upmpd Daemon Jun 24 19:20:39 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 24 19:20:39 volumio volumio[5735]: info: Loading plugin "my_music"... Jun 24 19:20:39 volumio volumio[5735]: info: Loading plugin "mpd"... Jun 24 19:20:41 volumio volumio[5735]: info: Loading plugin "upnp_browser"... Jun 24 19:20:44 volumio volumio[5735]: info: Loading plugin "networkfs"... Jun 24 19:20:45 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 24 19:20:45 volumio volumio[5735]: info: Loading plugin "alarm-clock"... Jun 24 19:20:46 volumio volumio[5735]: info: Loading plugin "airplay_emulation"... Jun 24 19:20:46 volumio volumio[5735]: info: Starting Shairport Sync Jun 24 19:20:46 volumio volumio[5735]: info: Loading plugin "last_100"... Jun 24 19:20:46 volumio volumio[5735]: info: Loading plugin "webradio"... Jun 24 19:20:46 volumio volumio[5735]: info: Loading plugin "i2s_dacs"... Jun 24 19:20:46 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 19:20:46 volumio volumio[5735]: info: Loading plugin "volumiodiscovery"... Jun 24 19:20:46 volumio volumio[5735]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 24 19:20:46 volumio node[5735]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 24 19:20:46 volumio node[5735]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 24 19:20:46 volumio node[5735]: *** WARNING *** For more information see Jun 24 19:20:46 volumio node[5735]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 24 19:20:46 volumio node[5735]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 24 19:20:46 volumio node[5735]: *** WARNING *** For more information see Jun 24 19:20:46 volumio volumio[5735]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 24 19:20:46 volumio volumio[5735]: *** WARNING *** For more information see Jun 24 19:20:46 volumio volumio[5735]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 24 19:20:46 volumio volumio[5735]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 24 19:20:46 volumio volumio[5735]: *** WARNING *** For more information see Jun 24 19:20:46 volumio volumio[5735]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 24 19:20:46 volumio volumio[5735]: Discovery: StartAdv! undefined Jun 24 19:20:46 volumio volumio[5735]: Discovery: Started advertising... Volumio - undefined Jun 24 19:20:47 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 24 19:20:47 volumio volumio[5735]: info: Loading plugin "auto_play"... Jun 24 19:20:47 volumio volumio[5735]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Jun 24 19:20:47 volumio volumio[5735]: info: Plugin gpio-buttons is not enabled Jun 24 19:20:47 volumio volumio[5735]: info: Loading plugin "albumart"... Jun 24 19:20:47 volumio volumio[5735]: info: Plugin example_plugin is not enabled Jun 24 19:20:47 volumio volumio[5735]: info: Loading plugin "updater_comm"... Jun 24 19:20:48 volumio volumio[5735]: info: Plugin mpdemulation is not enabled Jun 24 19:20:48 volumio volumio[5735]: info: Loading plugin "rest_api"... Jun 24 19:20:48 volumio volumio[5735]: info: Loading plugin "websocket"... Jun 24 19:20:48 volumio volumio[5735]: info: Loading plugin "Systeminfo"... Jun 24 19:20:50 volumio volumio[5735]: Forking 1 albumart workers Jun 24 19:20:52 volumio volumio[5735]: info: Plugin spop is not enabled Jun 24 19:20:52 volumio volumio[5735]: info: Loading plugin "volspotconnect2"... Jun 24 19:20:56 volumio volumio[5735]: info: Loading plugin "ledstatus"... Jun 24 19:20:57 volumio volumio[5735]: Starting albumart workers Jun 24 19:21:00 volumio volumio[5735]: info: Applying required configuration parameters for plugin ledstatus Jun 24 19:21:00 volumio volumio[5735]: info: ___________ START PLUGINS ___________ Jun 24 19:21:00 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 24 19:21:00 volumio volumio[5735]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 24 19:21:00 volumio volumio[5735]: info: [1750785660540] CoreMusicLibrary::Adding element Media Servers Jun 24 19:21:00 volumio volumio[5735]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 24 19:21:00 volumio volumio[5735]: info: [1750785660685] CoreMusicLibrary::Adding element Last_100 Jun 24 19:21:00 volumio volumio[5735]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 24 19:21:00 volumio volumio[5735]: info: [1750785660700] CoreMusicLibrary::Adding element Webradio Jun 24 19:21:00 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 24 19:21:00 volumio volumio[5735]: [SpotifyConnect] Creating VLS config file Jun 24 19:21:00 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:21:00 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:21:00 volumio volumio[5735]: [SpotifyConnect] Starting metadata listener Jun 24 19:21:00 volumio volumio[5735]: info: LedStatus : init GPIO Jun 24 19:21:00 volumio volumio[5735]: info: ------------------------------------------- Jun 24 19:21:00 volumio volumio[5735]: info: ----- MyVolumio plugins startup ---- Jun 24 19:21:00 volumio volumio[5735]: info: ------------------------------------------- Jun 24 19:21:00 volumio volumio[5735]: info: Loading plugins from folder /myvolumio/plugins Jun 24 19:21:00 volumio sudo[5781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jun 24 19:21:00 volumio volumio[5735]: info: Loading plugins from folder /data/myvolumio/plugins Jun 24 19:21:00 volumio volumio[5735]: info: Loading plugin "my_volumio"... Jun 24 19:21:00 volumio sudo[5781]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 19:21:01 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 24 19:21:01 volumio sudo[5781]: pam_unix(sudo:session): session closed for user root Jun 24 19:21:02 volumio volumio[5735]: info: Loading plugin "streaming_services"... Jun 24 19:21:03 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 19:21:03 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 19:21:03 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 19:21:03 volumio volumio[5735]: info: Streaming services startup Jun 24 19:21:03 volumio volumio[5735]: info: Loading i18n strings for locale cs Jun 24 19:21:03 volumio volumio[5735]: Updating browse sources language Jun 24 19:21:03 volumio sudo[5791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 24 19:21:03 volumio volumio[5735]: Cannot find translation for sourceMedia Servers Jun 24 19:21:03 volumio sudo[5791]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 19:21:03 volumio systemd[1]: Stopping Volumio Streaming Daemon... Jun 24 19:21:03 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::initPlayerControls Jun 24 19:21:04 volumio systemd[1]: Starting Volumio Streaming Daemon... Jun 24 19:21:04 volumio systemd[1]: Started Volumio Streaming Daemon. Jun 24 19:21:04 volumio sudo[5791]: pam_unix(sudo:session): session closed for user root Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jun 24 19:21:04 volumio volumio-streaming-daemon[5797]: ############################ Jun 24 19:21:04 volumio volumio-streaming-daemon[5797]: # Volumio Streaming Daemon # Jun 24 19:21:04 volumio volumio-streaming-daemon[5797]: # Running on port 7777 # Jun 24 19:21:04 volumio volumio-streaming-daemon[5797]: ############################ Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 24 19:21:04 volumio volumio[5735]: info: BOOT COMPLETED Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 19:21:04 volumio volumio[5735]: aplay: main:722: audio open error: Device or resource busy Jun 24 19:21:04 volumio volumio[5735]: Cannot play startup sound Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::Close All Modals sent Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::Close All Modals sent Jun 24 19:21:04 volumio volumio[5735]: Express server listening on port 3000 Jun 24 19:21:04 volumio volumio[5735]: Volumio Calling Home Jun 24 19:21:04 volumio volumio[5735]: (node:5735) Warning: N-API is an experimental feature and could change at any time. Jun 24 19:21:04 volumio volumio[5735]: info: MyVolumio not started Jun 24 19:21:04 volumio volumio[5735]: info: CoreStateMachine::resetVolumioState Jun 24 19:21:04 volumio volumio[5735]: info: CoreStateMachine::getcurrentVolume Jun 24 19:21:04 volumio volumio[5735]: info: CoreCommandRouter::volumioRetrievevolume Jun 24 19:21:05 volumio volumio[5735]: info: CoreStateMachine::updateTrackBlock Jun 24 19:21:05 volumio volumio[5735]: info: CorePlayQueue::getTrackBlock Jun 24 19:21:05 volumio sudo[5816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 24 19:21:05 volumio sudo[5816]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 19:21:05 volumio sudo[5816]: pam_unix(sudo:session): session closed for user root Jun 24 19:21:05 volumio volumio[5735]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 19:21:05 volumio volumio[5735]: { Error: ETXTBSY: text file is busy, open '/tmp/getvolume' Jun 24 19:21:05 volumio volumio[5735]: errno: -26, Jun 24 19:21:05 volumio volumio[5735]: code: 'ETXTBSY', Jun 24 19:21:05 volumio volumio[5735]: syscall: 'open', Jun 24 19:21:05 volumio volumio[5735]: path: '/tmp/getvolume' } Jun 24 19:21:05 volumio volumio[5735]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 19:21:08 volumio sudo[5832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-24 19:20 Jun 24 19:21:08 volumio sudo[5832]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="91bc32a3daa69e09170e613c40f8b5c279962098" VOLUMIO_FE_VERSION="9511ab07247d3b65ded550111191469fa3626bd6" VOLUMIO_BE_VERSION="78de34390ebc5df0b086e244ca969a4e0ddc40d1" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Jan 12 00:37:59 CET 2019" VOLUMIO_VERSION="2.526" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="fe6efee3fc492df251c9b38e25d0dec3"