-- Logs begin at Tue 2025-07-08 10:36:41 UTC, end at Tue 2025-07-08 12:39:37 UTC. --
Jul 08 12:38:00 volumiowerk volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 08 12:38:00 volumiowerk volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 12:38:01 volumiowerk volumio[1097]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:38:04 volumiowerk volumio[1097]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 08 12:38:04 volumiowerk volumio[1097]: TypeError: Cannot create property 'type' on string 'invalid server key'
Jul 08 12:38:04 volumiowerk volumio[1097]: at WebSocket.onError (/volumio/node_modules/engine.io-client/node_modules/ws/lib/WebSocket.js:450:16)
Jul 08 12:38:04 volumiowerk volumio[1097]: at emitOne (events.js:116:13)
Jul 08 12:38:04 volumiowerk volumio[1097]: at WebSocket.emit (events.js:211:7)
Jul 08 12:38:04 volumiowerk volumio[1097]: at ClientRequest.upgrade (/volumio/node_modules/engine.io-client/node_modules/ws/lib/WebSocket.js:738:12)
Jul 08 12:38:04 volumiowerk volumio[1097]: at Object.onceWrapper (events.js:319:30)
Jul 08 12:38:04 volumiowerk volumio[1097]: at emitThree (events.js:136:13)
Jul 08 12:38:04 volumiowerk volumio[1097]: at ClientRequest.emit (events.js:217:7)
Jul 08 12:38:04 volumiowerk volumio[1097]: at Socket.socketOnData (_http_client.js:472:11)
Jul 08 12:38:04 volumiowerk volumio[1097]: at emitOne (events.js:116:13)
Jul 08 12:38:04 volumiowerk volumio[1097]: at Socket.emit (events.js:211:7)
Jul 08 12:38:04 volumiowerk volumio[1097]: at addChunk (_stream_readable.js:263:12)
Jul 08 12:38:04 volumiowerk volumio[1097]: at readableAddChunk (_stream_readable.js:250:11)
Jul 08 12:38:04 volumiowerk volumio[1097]: at Socket.Readable.push (_stream_readable.js:208:10)
Jul 08 12:38:04 volumiowerk volumio[1097]: at TCP.onread (net.js:607:20)
Jul 08 12:38:04 volumiowerk volumio[1097]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 08 12:38:04 volumiowerk sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-08 12:37
Jul 08 12:38:04 volumiowerk sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:05 volumiowerk sudo[1430]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:06 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:38:06] [info] asio async_read_at_least error: system:104 (Connection reset by peer)
Jul 08 12:38:06 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:38:06] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error)
Jul 08 12:38:06 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:38:06] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006]
Jul 08 12:38:06 volumiowerk systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Jul 08 12:38:06 volumiowerk systemd[1]: Unit volumio.service entered failed state.
Jul 08 12:38:06 volumiowerk systemd[1]: Starting dynamicswap service...
Jul 08 12:38:06 volumiowerk systemd[1]: Started dynamicswap service.
Jul 08 12:38:06 volumiowerk systemd[1]: volumio.service holdoff time over, scheduling restart.
Jul 08 12:38:06 volumiowerk systemd[1]: Starting dynamicswap service...
Jul 08 12:38:06 volumiowerk systemd[1]: Started dynamicswap service.
Jul 08 12:38:06 volumiowerk systemd[1]: Stopping Volumio Backend Module...
Jul 08 12:38:06 volumiowerk systemd[1]: Starting Volumio Backend Module...
Jul 08 12:38:06 volumiowerk systemd[1]: Started Volumio Backend Module.
Jul 08 12:38:08 volumiowerk volumio[1451]: info: -------------------------------------------
Jul 08 12:38:08 volumiowerk volumio[1451]: info: ----- Volumio2 ----
Jul 08 12:38:08 volumiowerk volumio[1451]: info: -------------------------------------------
Jul 08 12:38:08 volumiowerk volumio[1451]: info: ----- System startup ----
Jul 08 12:38:08 volumiowerk volumio[1451]: info: -------------------------------------------
Jul 08 12:38:09 volumiowerk volumio[1451]: info: MYVOLUMIO Environment detected
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Plugin folders cleanup
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Scanning into folder /volumio/app/plugins/
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Scanning category audio_interface
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Scanning category miscellanea
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Scanning category music_service
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Scanning category plugins.json
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Scanning category system_controller
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Scanning category user_interface
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Scanning into folder /data/plugins/
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Scanning category miscellanea
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Scanning category music_service
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Scanning category system_controller
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Plugin folders cleanup completed
Jul 08 12:38:09 volumiowerk volumio[1451]: info: -------------------------------------------
Jul 08 12:38:09 volumiowerk volumio[1451]: info: ----- Core plugins startup ----
Jul 08 12:38:09 volumiowerk volumio[1451]: info: -------------------------------------------
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Loading plugins from folder /volumio/app/plugins/
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Adding plugin upnp to MyMusic Plugins
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Adding plugin upnp_browser to MyMusic Plugins
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Loading plugins from folder /data/plugins/
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Loading plugin "system"...
Jul 08 12:38:09 volumiowerk volumio[1451]: info: Loading plugin "appearance"...
Jul 08 12:38:11 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:38:11] [connect] Successful connection
Jul 08 12:38:11 volumiowerk volumio[1451]: info: Loading plugin "network"...
Jul 08 12:38:11 volumiowerk volumio[1451]: info: Refreshing Cached IP Addresses
Jul 08 12:38:11 volumiowerk sudo[1476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 08 12:38:11 volumiowerk volumio[1451]: info: Loading plugin "touch_display"...
Jul 08 12:38:11 volumiowerk sudo[1476]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:11 volumiowerk sudo[1476]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:11 volumiowerk sudo[1480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 08 12:38:11 volumiowerk sudo[1480]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:11 volumiowerk sudo[1480]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:11 volumiowerk volumio[1451]: info: Applying required configuration parameters for plugin touch_display
Jul 08 12:38:12 volumiowerk volumio[1451]: info: Loading plugin "services"...
Jul 08 12:38:12 volumiowerk volumio[1451]: info: Loading plugin "alsa_controller"...
Jul 08 12:38:12 volumiowerk volumio[1451]: info: Loading plugin "wizard"...
Jul 08 12:38:12 volumiowerk volumio[1451]: info: Loading plugin "volumio_command_line_client"...
Jul 08 12:38:12 volumiowerk volumio[1451]: info: Loading plugin "upnp"...
Jul 08 12:38:12 volumiowerk volumio[1451]: info: [1751978292254] Starting Upmpd Daemon
Jul 08 12:38:12 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 08 12:38:12 volumiowerk volumio[1451]: info: Loading plugin "my_music"...
Jul 08 12:38:12 volumiowerk volumio[1451]: info: Loading plugin "mpd"...
Jul 08 12:38:12 volumiowerk volumio[1451]: info: Loading plugin "upnp_browser"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "networkfs"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "alarm-clock"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "airplay_emulation"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Starting Shairport Sync
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "last_100"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "webradio"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "i2s_dacs"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "volumiodiscovery"...
Jul 08 12:38:13 volumiowerk volumio[1451]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 08 12:38:13 volumiowerk node[1451]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 08 12:38:13 volumiowerk node[1451]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 12:38:13 volumiowerk node[1451]: *** WARNING *** For more information see
Jul 08 12:38:13 volumiowerk node[1451]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 08 12:38:13 volumiowerk node[1451]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 12:38:13 volumiowerk node[1451]: *** WARNING *** For more information see
Jul 08 12:38:13 volumiowerk volumio[1451]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 12:38:13 volumiowerk volumio[1451]: *** WARNING *** For more information see
Jul 08 12:38:13 volumiowerk volumio[1451]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 08 12:38:13 volumiowerk volumio[1451]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 12:38:13 volumiowerk volumio[1451]: *** WARNING *** For more information see
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Applying required configuration parameters for plugin volumiodiscovery
Jul 08 12:38:13 volumiowerk volumio[1451]: Discovery: StartAdv! undefined
Jul 08 12:38:13 volumiowerk volumio[1451]: Discovery: Started advertising... Volumiowerk - undefined
Jul 08 12:38:13 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "auto_play"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "outputs"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "albumart"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Plugin example_plugin is not enabled
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "inputs"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "updater_comm"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Plugin mpdemulation is not enabled
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "rest_api"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "websocket"...
Jul 08 12:38:13 volumiowerk volumio[1451]: info: Loading plugin "radio_paradise"...
Jul 08 12:38:14 volumiowerk volumio[1451]: Forking 3 albumart workers
Jul 08 12:38:14 volumiowerk volumio[1451]: info: Applying required configuration parameters for plugin radio_paradise
Jul 08 12:38:14 volumiowerk volumio[1451]: info: [1751978294219] [RadioParadise] API delay: 5
Jul 08 12:38:14 volumiowerk volumio[1451]: info: Loading plugin "backup_restore"...
Jul 08 12:38:14 volumiowerk volumio[1451]: info: ___________ START PLUGINS ___________
Jul 08 12:38:14 volumiowerk volumio[1451]: info: Loading i18n strings for locale nl
Jul 08 12:38:14 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 08 12:38:14 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 12:38:14 volumiowerk volumio[1451]: info: [1751978294592] CoreMusicLibrary::Adding element Media Servers
Jul 08 12:38:14 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 12:38:14 volumiowerk sudo[1529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Jul 08 12:38:14 volumiowerk sudo[1529]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:14 volumiowerk systemd[1]: Reloading.
Jul 08 12:38:14 volumiowerk volumio[1451]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 08 12:38:14 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service'
Jul 08 12:38:14 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service'
Jul 08 12:38:14 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service'
Jul 08 12:38:14 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service'
Jul 08 12:38:14 volumiowerk volumio[1451]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 08 12:38:14 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 12:38:14 volumiowerk volumio[1451]: info: [1751978294896] CoreMusicLibrary::Adding element Last_100
Jul 08 12:38:14 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 12:38:14 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 12:38:14 volumiowerk volumio[1451]: info: [1751978294907] CoreMusicLibrary::Adding element Webradio
Jul 08 12:38:14 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 12:38:14 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 08 12:38:14 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 12:38:14 volumiowerk sudo[1529]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:14 volumiowerk volumio[1451]: info: [1751978294969] CoreMusicLibrary::Adding element Radio Paradise
Jul 08 12:38:14 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 12:38:15 volumiowerk volumio[1451]: info: -------------------------------------------
Jul 08 12:38:15 volumiowerk volumio[1451]: info: ----- MyVolumio plugins startup ----
Jul 08 12:38:15 volumiowerk volumio[1451]: info: -------------------------------------------
Jul 08 12:38:15 volumiowerk volumio[1451]: info: [MyVolumio PluginManager] Fetching plans data....
Jul 08 12:38:15 volumiowerk volumio[1451]: info: Loading i18n strings for locale nl
Jul 08 12:38:15 volumiowerk volumio[1451]: Updating browse sources language
Jul 08 12:38:15 volumiowerk volumio[1451]: Cannot find translation for sourceMedia Servers
Jul 08 12:38:15 volumiowerk volumio[1451]: Cannot find translation for sourceRadio Paradise
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::initPlayerControls
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Jul 08 12:38:15 volumiowerk volumio[1451]: Starting albumart workers
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:15 volumiowerk volumio[1451]: Starting albumart workers
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 08 12:38:15 volumiowerk volumio[1451]: info: BOOT COMPLETED
Jul 08 12:38:15 volumiowerk volumio[1451]: [Metrics] CommandRouter: 6s 684.50ms
Jul 08 12:38:15 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 12:38:15 volumiowerk volumio[1451]: Starting albumart workers
Jul 08 12:38:15 volumiowerk kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Jul 08 12:38:20 volumiowerk volumio[1451]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Jul 08 12:38:20 volumiowerk volumio[1451]: info: CoreCommandRouter::Close All Modals sent
Jul 08 12:38:20 volumiowerk volumio[1451]: info: CoreCommandRouter::Close All Modals sent
Jul 08 12:38:20 volumiowerk volumio[1451]: Express server listening on port 3000
Jul 08 12:38:20 volumiowerk volumio[1451]: [Metrics] WebUI: 12s 484.58ms
Jul 08 12:38:20 volumiowerk volumio[1451]: Volumio Calling Home
Jul 08 12:38:20 volumiowerk volumio[1451]: info: CoreStateMachine::resetVolumioState
Jul 08 12:38:20 volumiowerk volumio[1451]: info: CoreStateMachine::getcurrentVolume
Jul 08 12:38:20 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioRetrievevolume
Jul 08 12:38:20 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 12:38:20 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:21 volumiowerk volumio[1451]: info: Setting Device type: Raspberry PI
Jul 08 12:38:21 volumiowerk volumio[1451]: info: touch_display: systemctl daemon-reload succeeded.
Jul 08 12:38:21 volumiowerk volumio[1451]: info: MPD running with PID676
Jul 08 12:38:21 volumiowerk volumio[1451]: ,establishing connection
Jul 08 12:38:21 volumiowerk volumio[1451]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:38:21 volumiowerk sudo[1595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Jul 08 12:38:21 volumiowerk sudo[1595]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:21 volumiowerk systemd[1]: Started Volumio Kiosk.
Jul 08 12:38:21 volumiowerk sudo[1595]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:21 volumiowerk volumio[1451]: info: VolumeController:: Volume=54 Mute =false
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreStateMachine::pushState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CorePlayQueue::getTrack 0
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioPushState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreStateMachine::updateTrackBlock
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CorePlayQueue::getTrackBlock
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioRetrievevolume
Jul 08 12:38:21 volumiowerk volumio[1451]: info:
Jul 08 12:38:21 volumiowerk volumio[1451]: ---------------------------- Client requests Volume 55
Jul 08 12:38:21 volumiowerk volumio[1451]: info: VolumeController::SetAlsaVolume55
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreStateMachine::pushState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CorePlayQueue::getTrack 0
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioPushState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 12:38:21 volumiowerk volumio[1451]: info: touch_display: systemctl start volumio-kiosk.service succeeded.
Jul 08 12:38:21 volumiowerk volumio[1451]: info: touch_display: Volumio Kiosk started
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioGetState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CorePlayQueue::getTrack 0
Jul 08 12:38:21 volumiowerk volumio[1451]: info: Reloading queue from file
Jul 08 12:38:21 volumiowerk volumio[1451]: info: Setting volume on startup at 55
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreStateMachine::setRepeat null single undefined
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreStateMachine::pushState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CorePlayQueue::getTrack 0
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioPushState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreStateMachine::setRandom null
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreStateMachine::pushState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CorePlayQueue::getTrack 0
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioPushState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 12:38:21 volumiowerk volumio[1451]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 08 12:38:21 volumiowerk volumio[1451]: info: VolumeController:: Volume=54 Mute =false
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreStateMachine::pushState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CorePlayQueue::getTrack 0
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioPushState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 12:38:21 volumiowerk volumio[1451]: info: Starting Shairport Sync
Jul 08 12:38:21 volumiowerk volumio[1451]: info: Starting Shairport Sync
Jul 08 12:38:21 volumiowerk sudo[1610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 08 12:38:21 volumiowerk sudo[1610]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:21 volumiowerk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 08 12:38:21 volumiowerk sudo[1615]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 08 12:38:21 volumiowerk sudo[1615]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:21 volumiowerk systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Jul 08 12:38:21 volumiowerk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 08 12:38:21 volumiowerk sudo[1610]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:21 volumiowerk volumio[1451]: info: touch_display: No Raspberry Pi Foundation touch screen detected.
Jul 08 12:38:21 volumiowerk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 08 12:38:21 volumiowerk systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Jul 08 12:38:21 volumiowerk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 08 12:38:21 volumiowerk sudo[1615]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:21 volumiowerk volumio[1451]: info: Shairport-Sync Started
Jul 08 12:38:21 volumiowerk volumio[1451]: Error adding Membership: Error: addMembership EINVAL
Jul 08 12:38:21 volumiowerk sudo[1639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf
Jul 08 12:38:21 volumiowerk sudo[1639]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:21 volumiowerk sudo[1639]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:21 volumiowerk volumio[1451]: info: Shairport-Sync Started
Jul 08 12:38:21 volumiowerk volumio[1451]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Jul 08 12:38:21 volumiowerk volumio[1451]: info: touch_display: Setting screensaver timeout to 120 seconds.
Jul 08 12:38:21 volumiowerk volumio[1451]: info: touch_display: Touchscreen transformation matrix removed.
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioGetState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CorePlayQueue::getTrack 0
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioGetState
Jul 08 12:38:21 volumiowerk volumio[1451]: info: CorePlayQueue::getTrack 0
Jul 08 12:38:22 volumiowerk sudo[1666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 08 12:38:22 volumiowerk sudo[1666]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:22 volumiowerk sudo[1666]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:22 volumiowerk sudo[1673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 08 12:38:22 volumiowerk sudo[1677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 08 12:38:22 volumiowerk sudo[1673]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:22 volumiowerk sudo[1677]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:22 volumiowerk sudo[1673]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:22 volumiowerk systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 08 12:38:22 volumiowerk sudo[1677]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:22 volumiowerk volumio[1451]: info: Upmpdcli Daemon Started
Jul 08 12:38:23 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:38:23] [connect] Successful connection
Jul 08 12:38:23 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:38:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1751978303 101
Jul 08 12:38:24 volumiowerk volumio[1451]: info: CoreCommandRouter::volumioGetState
Jul 08 12:38:24 volumiowerk volumio[1451]: info: CorePlayQueue::getTrack 0
Jul 08 12:38:24 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 08 12:38:24 volumiowerk volumio[1451]: info: Listing playlists
Jul 08 12:38:26 volumiowerk volumio[1451]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:38:31 volumiowerk volumio[1451]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:38:36 volumiowerk volumio[1451]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:38:41 volumiowerk volumio[1451]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:38:44 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 08 12:38:44 volumiowerk volumio[1451]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 12:38:46 volumiowerk volumio[1451]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:38:48 volumiowerk volumio[1451]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 08 12:38:48 volumiowerk volumio[1451]: TypeError: Cannot create property 'type' on string 'invalid server key'
Jul 08 12:38:48 volumiowerk volumio[1451]: at WebSocket.onError (/volumio/node_modules/engine.io-client/node_modules/ws/lib/WebSocket.js:450:16)
Jul 08 12:38:48 volumiowerk volumio[1451]: at emitOne (events.js:116:13)
Jul 08 12:38:48 volumiowerk volumio[1451]: at WebSocket.emit (events.js:211:7)
Jul 08 12:38:48 volumiowerk volumio[1451]: at ClientRequest.upgrade (/volumio/node_modules/engine.io-client/node_modules/ws/lib/WebSocket.js:738:12)
Jul 08 12:38:48 volumiowerk volumio[1451]: at Object.onceWrapper (events.js:319:30)
Jul 08 12:38:48 volumiowerk volumio[1451]: at emitThree (events.js:136:13)
Jul 08 12:38:48 volumiowerk volumio[1451]: at ClientRequest.emit (events.js:217:7)
Jul 08 12:38:48 volumiowerk volumio[1451]: at Socket.socketOnData (_http_client.js:472:11)
Jul 08 12:38:48 volumiowerk volumio[1451]: at emitOne (events.js:116:13)
Jul 08 12:38:48 volumiowerk volumio[1451]: at Socket.emit (events.js:211:7)
Jul 08 12:38:48 volumiowerk volumio[1451]: at addChunk (_stream_readable.js:263:12)
Jul 08 12:38:48 volumiowerk volumio[1451]: at readableAddChunk (_stream_readable.js:250:11)
Jul 08 12:38:48 volumiowerk volumio[1451]: at Socket.Readable.push (_stream_readable.js:208:10)
Jul 08 12:38:48 volumiowerk volumio[1451]: at TCP.onread (net.js:607:20)
Jul 08 12:38:48 volumiowerk volumio[1451]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 08 12:38:49 volumiowerk sudo[1728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-08 12:37
Jul 08 12:38:49 volumiowerk sudo[1728]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:49 volumiowerk sudo[1728]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:51 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:38:51] [info] asio async_read_at_least error: system:104 (Connection reset by peer)
Jul 08 12:38:51 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:38:51] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error)
Jul 08 12:38:51 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:38:51] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006]
Jul 08 12:38:51 volumiowerk systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Jul 08 12:38:51 volumiowerk systemd[1]: Unit volumio.service entered failed state.
Jul 08 12:38:51 volumiowerk systemd[1]: Starting dynamicswap service...
Jul 08 12:38:51 volumiowerk systemd[1]: Started dynamicswap service.
Jul 08 12:38:51 volumiowerk systemd[1]: volumio.service holdoff time over, scheduling restart.
Jul 08 12:38:51 volumiowerk systemd[1]: Starting dynamicswap service...
Jul 08 12:38:51 volumiowerk systemd[1]: Started dynamicswap service.
Jul 08 12:38:51 volumiowerk systemd[1]: Stopping Volumio Backend Module...
Jul 08 12:38:51 volumiowerk systemd[1]: Starting Volumio Backend Module...
Jul 08 12:38:51 volumiowerk systemd[1]: Started Volumio Backend Module.
Jul 08 12:38:53 volumiowerk volumio[1750]: info: -------------------------------------------
Jul 08 12:38:53 volumiowerk volumio[1750]: info: ----- Volumio2 ----
Jul 08 12:38:53 volumiowerk volumio[1750]: info: -------------------------------------------
Jul 08 12:38:53 volumiowerk volumio[1750]: info: ----- System startup ----
Jul 08 12:38:53 volumiowerk volumio[1750]: info: -------------------------------------------
Jul 08 12:38:53 volumiowerk volumio[1750]: info: MYVOLUMIO Environment detected
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Plugin folders cleanup
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Scanning into folder /volumio/app/plugins/
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Scanning category audio_interface
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Scanning category miscellanea
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Scanning category music_service
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Scanning category plugins.json
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Scanning category system_controller
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Scanning category user_interface
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Scanning into folder /data/plugins/
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Scanning category miscellanea
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Scanning category music_service
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Scanning category system_controller
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Plugin folders cleanup completed
Jul 08 12:38:53 volumiowerk volumio[1750]: info: -------------------------------------------
Jul 08 12:38:53 volumiowerk volumio[1750]: info: ----- Core plugins startup ----
Jul 08 12:38:53 volumiowerk volumio[1750]: info: -------------------------------------------
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Loading plugins from folder /volumio/app/plugins/
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Adding plugin upnp to MyMusic Plugins
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Adding plugin upnp_browser to MyMusic Plugins
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Loading plugins from folder /data/plugins/
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Loading plugin "system"...
Jul 08 12:38:53 volumiowerk volumio[1750]: info: Loading plugin "appearance"...
Jul 08 12:38:56 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:38:56] [connect] Successful connection
Jul 08 12:38:56 volumiowerk volumio[1750]: info: Loading plugin "network"...
Jul 08 12:38:56 volumiowerk volumio[1750]: info: Refreshing Cached IP Addresses
Jul 08 12:38:56 volumiowerk sudo[1776]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 08 12:38:56 volumiowerk volumio[1750]: info: Loading plugin "touch_display"...
Jul 08 12:38:56 volumiowerk sudo[1776]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:56 volumiowerk sudo[1776]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:56 volumiowerk sudo[1780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 08 12:38:56 volumiowerk sudo[1780]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:56 volumiowerk sudo[1780]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:56 volumiowerk volumio[1750]: info: Applying required configuration parameters for plugin touch_display
Jul 08 12:38:56 volumiowerk volumio[1750]: info: Loading plugin "services"...
Jul 08 12:38:56 volumiowerk volumio[1750]: info: Loading plugin "alsa_controller"...
Jul 08 12:38:56 volumiowerk volumio[1750]: info: Loading plugin "wizard"...
Jul 08 12:38:56 volumiowerk volumio[1750]: info: Loading plugin "volumio_command_line_client"...
Jul 08 12:38:56 volumiowerk volumio[1750]: info: Loading plugin "upnp"...
Jul 08 12:38:56 volumiowerk volumio[1750]: info: [1751978336816] Starting Upmpd Daemon
Jul 08 12:38:56 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 08 12:38:56 volumiowerk volumio[1750]: info: Loading plugin "my_music"...
Jul 08 12:38:56 volumiowerk volumio[1750]: info: Loading plugin "mpd"...
Jul 08 12:38:57 volumiowerk volumio[1750]: info: Loading plugin "upnp_browser"...
Jul 08 12:38:57 volumiowerk volumio[1750]: info: Loading plugin "networkfs"...
Jul 08 12:38:57 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 08 12:38:57 volumiowerk volumio[1750]: info: Loading plugin "alarm-clock"...
Jul 08 12:38:57 volumiowerk volumio[1750]: info: Loading plugin "airplay_emulation"...
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Starting Shairport Sync
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "last_100"...
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "webradio"...
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "i2s_dacs"...
Jul 08 12:38:58 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "volumiodiscovery"...
Jul 08 12:38:58 volumiowerk volumio[1750]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 08 12:38:58 volumiowerk node[1750]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 08 12:38:58 volumiowerk node[1750]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 12:38:58 volumiowerk node[1750]: *** WARNING *** For more information see
Jul 08 12:38:58 volumiowerk node[1750]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 08 12:38:58 volumiowerk node[1750]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 12:38:58 volumiowerk node[1750]: *** WARNING *** For more information see
Jul 08 12:38:58 volumiowerk volumio[1750]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 12:38:58 volumiowerk volumio[1750]: *** WARNING *** For more information see
Jul 08 12:38:58 volumiowerk volumio[1750]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 08 12:38:58 volumiowerk volumio[1750]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 12:38:58 volumiowerk volumio[1750]: *** WARNING *** For more information see
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Applying required configuration parameters for plugin volumiodiscovery
Jul 08 12:38:58 volumiowerk volumio[1750]: Discovery: StartAdv! undefined
Jul 08 12:38:58 volumiowerk volumio[1750]: Discovery: Started advertising... Volumiowerk - undefined
Jul 08 12:38:58 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "auto_play"...
Jul 08 12:38:58 volumiowerk volumio[1750]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "outputs"...
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "albumart"...
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Plugin example_plugin is not enabled
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "inputs"...
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "updater_comm"...
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Plugin mpdemulation is not enabled
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "rest_api"...
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "websocket"...
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "radio_paradise"...
Jul 08 12:38:58 volumiowerk volumio[1750]: Forking 3 albumart workers
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Applying required configuration parameters for plugin radio_paradise
Jul 08 12:38:58 volumiowerk volumio[1750]: info: [1751978338846] [RadioParadise] API delay: 5
Jul 08 12:38:58 volumiowerk volumio[1750]: info: Loading plugin "backup_restore"...
Jul 08 12:38:59 volumiowerk volumio[1750]: info: ___________ START PLUGINS ___________
Jul 08 12:38:59 volumiowerk volumio[1750]: info: Loading i18n strings for locale nl
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 12:38:59 volumiowerk volumio[1750]: info: [1751978339214] CoreMusicLibrary::Adding element Media Servers
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 12:38:59 volumiowerk sudo[1828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Jul 08 12:38:59 volumiowerk sudo[1828]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:38:59 volumiowerk systemd[1]: Reloading.
Jul 08 12:38:59 volumiowerk volumio[1750]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 08 12:38:59 volumiowerk volumio[1750]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 12:38:59 volumiowerk volumio[1750]: info: [1751978339503] CoreMusicLibrary::Adding element Last_100
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 12:38:59 volumiowerk volumio[1750]: info: [1751978339508] CoreMusicLibrary::Adding element Webradio
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 12:38:59 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service'
Jul 08 12:38:59 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service'
Jul 08 12:38:59 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service'
Jul 08 12:38:59 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service'
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 12:38:59 volumiowerk volumio[1750]: info: [1751978339556] CoreMusicLibrary::Adding element Radio Paradise
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 12:38:59 volumiowerk volumio[1750]: info: -------------------------------------------
Jul 08 12:38:59 volumiowerk volumio[1750]: info: ----- MyVolumio plugins startup ----
Jul 08 12:38:59 volumiowerk volumio[1750]: info: -------------------------------------------
Jul 08 12:38:59 volumiowerk volumio[1750]: info: [MyVolumio PluginManager] Fetching plans data....
Jul 08 12:38:59 volumiowerk volumio[1750]: info: Loading i18n strings for locale nl
Jul 08 12:38:59 volumiowerk volumio[1750]: Updating browse sources language
Jul 08 12:38:59 volumiowerk volumio[1750]: Cannot find translation for sourceMedia Servers
Jul 08 12:38:59 volumiowerk volumio[1750]: Cannot find translation for sourceRadio Paradise
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 12:38:59 volumiowerk sudo[1828]: pam_unix(sudo:session): session closed for user root
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::initPlayerControls
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:38:59 volumiowerk volumio[1750]: Starting albumart workers
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 08 12:38:59 volumiowerk volumio[1750]: info: BOOT COMPLETED
Jul 08 12:38:59 volumiowerk volumio[1750]: [Metrics] CommandRouter: 6s 692.94ms
Jul 08 12:38:59 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 12:38:59 volumiowerk volumio[1750]: Starting albumart workers
Jul 08 12:38:59 volumiowerk volumio[1750]: Starting albumart workers
Jul 08 12:38:59 volumiowerk kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Jul 08 12:39:05 volumiowerk volumio[1750]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::Close All Modals sent
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::Close All Modals sent
Jul 08 12:39:05 volumiowerk volumio[1750]: Express server listening on port 3000
Jul 08 12:39:05 volumiowerk volumio[1750]: [Metrics] WebUI: 12s 521.18ms
Jul 08 12:39:05 volumiowerk volumio[1750]: Volumio Calling Home
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreStateMachine::resetVolumioState
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreStateMachine::getcurrentVolume
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioRetrievevolume
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 12:39:05 volumiowerk volumio[1750]: info: Volumio called home
Jul 08 12:39:05 volumiowerk volumio[1750]: info: Setting Device type: Raspberry PI
Jul 08 12:39:05 volumiowerk volumio[1750]: info: touch_display: systemctl daemon-reload succeeded.
Jul 08 12:39:05 volumiowerk volumio[1750]: info: MPD running with PID676
Jul 08 12:39:05 volumiowerk volumio[1750]: ,establishing connection
Jul 08 12:39:05 volumiowerk sudo[1893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Jul 08 12:39:05 volumiowerk volumio[1750]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:39:05 volumiowerk sudo[1893]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:39:05 volumiowerk systemd[1]: Started Volumio Kiosk.
Jul 08 12:39:05 volumiowerk sudo[1893]: pam_unix(sudo:session): session closed for user root
Jul 08 12:39:05 volumiowerk volumio[1750]: info: VolumeController:: Volume=54 Mute =false
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreStateMachine::pushState
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CorePlayQueue::getTrack 0
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioPushState
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreStateMachine::updateTrackBlock
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CorePlayQueue::getTrackBlock
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioRetrievevolume
Jul 08 12:39:05 volumiowerk volumio[1750]: info:
Jul 08 12:39:05 volumiowerk volumio[1750]: ---------------------------- Client requests Volume 55
Jul 08 12:39:05 volumiowerk volumio[1750]: info: VolumeController::SetAlsaVolume55
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreStateMachine::pushState
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CorePlayQueue::getTrack 0
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioPushState
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 12:39:05 volumiowerk volumio[1750]: info: touch_display: systemctl start volumio-kiosk.service succeeded.
Jul 08 12:39:05 volumiowerk volumio[1750]: info: touch_display: Volumio Kiosk started
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioGetState
Jul 08 12:39:05 volumiowerk volumio[1750]: info: CorePlayQueue::getTrack 0
Jul 08 12:39:06 volumiowerk volumio[1750]: info: Reloading queue from file
Jul 08 12:39:06 volumiowerk volumio[1750]: info: Setting volume on startup at 55
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreStateMachine::setRepeat null single undefined
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreStateMachine::pushState
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CorePlayQueue::getTrack 0
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioPushState
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreStateMachine::setRandom null
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreStateMachine::pushState
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CorePlayQueue::getTrack 0
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioPushState
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 12:39:06 volumiowerk volumio[1750]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Jul 08 12:39:06 volumiowerk volumio[1750]: info: VolumeController:: Volume=54 Mute =false
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreStateMachine::pushState
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CorePlayQueue::getTrack 0
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioPushState
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 12:39:06 volumiowerk volumio[1750]: info: Starting Shairport Sync
Jul 08 12:39:06 volumiowerk volumio[1750]: info: Starting Shairport Sync
Jul 08 12:39:06 volumiowerk sudo[1908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 08 12:39:06 volumiowerk sudo[1908]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:39:06 volumiowerk sudo[1912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 08 12:39:06 volumiowerk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 08 12:39:06 volumiowerk sudo[1912]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:39:06 volumiowerk systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Jul 08 12:39:06 volumiowerk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 08 12:39:06 volumiowerk sudo[1908]: pam_unix(sudo:session): session closed for user root
Jul 08 12:39:06 volumiowerk volumio[1750]: info: touch_display: No Raspberry Pi Foundation touch screen detected.
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioGetState
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CorePlayQueue::getTrack 0
Jul 08 12:39:06 volumiowerk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 08 12:39:06 volumiowerk systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Jul 08 12:39:06 volumiowerk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 08 12:39:06 volumiowerk sudo[1912]: pam_unix(sudo:session): session closed for user root
Jul 08 12:39:06 volumiowerk sudo[1937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf
Jul 08 12:39:06 volumiowerk sudo[1937]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:39:06 volumiowerk volumio[1750]: info: Shairport-Sync Started
Jul 08 12:39:06 volumiowerk volumio[1750]: Error adding Membership: Error: addMembership EINVAL
Jul 08 12:39:06 volumiowerk sudo[1937]: pam_unix(sudo:session): session closed for user root
Jul 08 12:39:06 volumiowerk volumio[1750]: Discovery: adding 0d0b458b-95fd-491e-b7c3-17e450230262
Jul 08 12:39:06 volumiowerk volumio[1750]: info: mDNS: Found device Volumiowerk
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioGetState
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CorePlayQueue::getTrack 0
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 08 12:39:06 volumiowerk volumio[1750]: info: Listing playlists
Jul 08 12:39:06 volumiowerk volumio[1750]: info: Shairport-Sync Started
Jul 08 12:39:06 volumiowerk volumio[1750]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Jul 08 12:39:06 volumiowerk volumio[1750]: info: touch_display: Setting screensaver timeout to 120 seconds.
Jul 08 12:39:06 volumiowerk volumio[1750]: info: touch_display: Touchscreen transformation matrix removed.
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioGetState
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CorePlayQueue::getTrack 0
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CoreCommandRouter::volumioGetState
Jul 08 12:39:06 volumiowerk volumio[1750]: info: CorePlayQueue::getTrack 0
Jul 08 12:39:06 volumiowerk sudo[1964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 08 12:39:06 volumiowerk sudo[1964]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:39:06 volumiowerk sudo[1964]: pam_unix(sudo:session): session closed for user root
Jul 08 12:39:06 volumiowerk sudo[1967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 08 12:39:06 volumiowerk sudo[1967]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:39:06 volumiowerk sudo[1967]: pam_unix(sudo:session): session closed for user root
Jul 08 12:39:07 volumiowerk sudo[1982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 08 12:39:07 volumiowerk sudo[1982]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 12:39:07 volumiowerk systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 08 12:39:07 volumiowerk sudo[1982]: pam_unix(sudo:session): session closed for user root
Jul 08 12:39:07 volumiowerk volumio[1750]: info: Upmpdcli Daemon Started
Jul 08 12:39:08 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:39:08] [connect] Successful connection
Jul 08 12:39:08 volumiowerk volumio-remote-updater[608]: [2025-07-08 12:39:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1751978348 101
Jul 08 12:39:10 volumiowerk volumio[1750]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:39:15 volumiowerk volumio[1750]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:39:20 volumiowerk volumio[1750]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:39:25 volumiowerk volumio[1750]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:39:29 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 08 12:39:29 volumiowerk volumio[1750]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 12:39:30 volumiowerk volumio[1750]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:39:35 volumiowerk volumio[1750]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Jul 08 12:39:37 volumiowerk volumio[1750]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 08 12:39:37 volumiowerk volumio[1750]: { Error: connect ETIMEDOUT 127.0.0.1:6600
Jul 08 12:39:37 volumiowerk volumio[1750]: at Object._errnoException (util.js:1022:11)
Jul 08 12:39:37 volumiowerk volumio[1750]: at _exceptionWithHostPort (util.js:1044:20)
Jul 08 12:39:37 volumiowerk volumio[1750]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Jul 08 12:39:37 volumiowerk volumio[1750]: code: 'ETIMEDOUT',
Jul 08 12:39:37 volumiowerk volumio[1750]: errno: 'ETIMEDOUT',
Jul 08 12:39:37 volumiowerk volumio[1750]: syscall: 'connect',
Jul 08 12:39:37 volumiowerk volumio[1750]: address: '127.0.0.1',
Jul 08 12:39:37 volumiowerk volumio[1750]: port: 6600 }
Jul 08 12:39:37 volumiowerk volumio[1750]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 08 12:39:37 volumiowerk sudo[2001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-08 12:38
Jul 08 12:39:37 volumiowerk sudo[2001]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae"
VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021"
VOLUMIO_VERSION="2.917"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"