-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sat 2026-04-11 13:29:52 CEST. --
Apr 11 13:28:00 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 11 13:28:00 volumio volumio[1092]: info: Preload queue cleared
Apr 11 13:28:03 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:03 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:03 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:03 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:03 volumio volumio[1092]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:28:08 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:08 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:08 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:08 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:08 volumio volumio[1092]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:28:10 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 11 13:28:10 volumio volumio[1092]: info: Preload queue cleared
Apr 11 13:28:12 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 11 13:28:12 volumio volumio[1092]: info: Preload queue cleared
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$10
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$11
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$12
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$13
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$14
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$15
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$16
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$17
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$18
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$19
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1A
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1B
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1C
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1D
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1E
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$0
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$2
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$3
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$4
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$5
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$6
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$7
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$8
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$9
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$A
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$B
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$C
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$D
Apr 11 13:28:12 volumio volumio[1092]: info: Preloading song: upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$E
Apr 11 13:28:12 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$10 in service upnp_browser
Apr 11 13:28:12 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$11 in service upnp_browser
Apr 11 13:28:12 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$12 in service upnp_browser
Apr 11 13:28:12 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$13 in service upnp_browser
Apr 11 13:28:12 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$14 in service upnp_browser
Apr 11 13:28:12 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$15 in service upnp_browser
Apr 11 13:28:12 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$16 in service upnp_browser
Apr 11 13:28:12 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$17 in service upnp_browser
Apr 11 13:28:12 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$18 in service upnp_browser
Apr 11 13:28:12 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$19 in service upnp_browser
Apr 11 13:28:12 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1A in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1B in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1C in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1D in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1E in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$0 in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$1 in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$2 in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$3 in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$4 in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$5 in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$6 in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$7 in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$8 in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:13 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:13 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:13 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:13 volumio volumio[1092]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$9 in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$A in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$B in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$C in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$D in service upnp_browser
Apr 11 13:28:13 volumio volumio[1092]: info: Exploding uri upnp/http://192.168.1.1:8200/ctl/ContentDir@64$0$1$3$0$E in service upnp_browser
Apr 11 13:28:18 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:18 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:18 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:18 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:18 volumio volumio[1092]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:28:23 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:23 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:24 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:24 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:24 volumio volumio[1092]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:28:28 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState
Apr 11 13:28:28 volumio volumio[1092]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:29 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:29 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:29 volumio volumio[1092]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:29 volumio volumio[1092]: info: Discovery: Restarting Browsing
Apr 11 13:28:29 volumio volumio[1092]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:28:30 volumio ntpd[811]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 13:28:31 volumio volumio[1092]: info: Retrieving Cloud Streaming UI
Apr 11 13:28:31 volumio volumio[1092]: info: Getting Tidal Cloud Configuration
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 13:28:31 volumio volumio[1092]: info: Getting Qobuz Cloud Configuration
Apr 11 13:28:31 volumio volumio[1092]: info: Asking plugin for UI Config
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 13:28:31 volumio volumio[1092]: info: Getting Spotify Cloud Configuration
Apr 11 13:28:31 volumio volumio[1092]: info: Asking plugin for UI Config
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 13:28:31 volumio volumio[1092]: info: Saving Spotify Acccount
Apr 11 13:28:31 volumio volumio[1092]: info: Got Tidal Cloud Configuration
Apr 11 13:28:31 volumio volumio[1092]: info: Got it
Apr 11 13:28:31 volumio volumio[1092]: info: Got it
Apr 11 13:28:31 volumio volumio[1092]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 13:28:31 volumio volumio[1092]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 11 13:28:31 volumio volumio[1092]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 11 13:28:32 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:28:32 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 11 13:28:34 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Apr 11 13:28:34 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Apr 11 13:28:34 volumio volumio[1092]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 13:28:34 volumio volumio[1092]: Error: getaddrinfo -3007
Apr 11 13:28:34 volumio volumio[1092]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Apr 11 13:28:34 volumio volumio[1092]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Apr 11 13:28:34 volumio volumio[1092]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Apr 11 13:28:34 volumio volumio[1092]: code: -3007,
Apr 11 13:28:34 volumio volumio[1092]: errno: -3007,
Apr 11 13:28:34 volumio volumio[1092]: syscall: 'getaddrinfo'
Apr 11 13:28:34 volumio volumio[1092]: }
Apr 11 13:28:34 volumio volumio[1092]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 13:28:35 volumio sudo[2495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-11 13:27
Apr 11 13:28:35 volumio sudo[2495]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:35 volumio sudo[2495]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:36 volumio volumio5-onboarding[1524]: time=2026-04-11T13:28:36.025+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF"
Apr 11 13:28:36 volumio volumio5-onboarding[1524]: time=2026-04-11T13:28:36.029+02:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:57998->127.0.0.1:3000: read: connection reset by peer"
Apr 11 13:28:36 volumio volumio-remote-updater[616]: [2026-04-11 13:28:36] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 11 13:28:36 volumio volumio-remote-updater[616]: [2026-04-11 13:28:36] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 11 13:28:36 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 11 13:28:36 volumio systemd[1]: media-Musica.mount: Succeeded.
Apr 11 13:28:36 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 11 13:28:36 volumio systemd[1]: Started dynamicswap service.
Apr 11 13:28:36 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 11 13:28:36 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1.
Apr 11 13:28:36 volumio systemd[1]: Stopped Volumio Backend Module.
Apr 11 13:28:36 volumio systemd[1]: Started Volumio Backend Module.
Apr 11 13:28:36 volumio systemd[1]: dynamicswap.service: Succeeded.
Apr 11 13:28:37 volumio volumio5-onboarding[1524]: time=2026-04-11T13:28:37.033+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 11 13:28:38 volumio volumio5-onboarding[1524]: time=2026-04-11T13:28:38.037+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 11 13:28:39 volumio volumio[2511]: info: -------------------------------------------
Apr 11 13:28:39 volumio volumio[2511]: info: ----- Volumio3 ----
Apr 11 13:28:39 volumio volumio[2511]: info: -------------------------------------------
Apr 11 13:28:39 volumio volumio[2511]: info: ----- System startup ----
Apr 11 13:28:39 volumio volumio[2511]: info: -------------------------------------------
Apr 11 13:28:41 volumio volumio[2511]: info: MYVOLUMIO Environment detected
Apr 11 13:28:41 volumio volumio-remote-updater[616]: [2026-04-11 13:28:41] [connect] Successful connection
Apr 11 13:28:41 volumio volumio[2511]: info: Plugin folders cleanup
Apr 11 13:28:41 volumio volumio[2511]: info: Scanning into folder /volumio/app/plugins/
Apr 11 13:28:41 volumio volumio[2511]: info: Scanning category audio_interface
Apr 11 13:28:41 volumio volumio[2511]: info: Scanning category miscellanea
Apr 11 13:28:41 volumio volumio[2511]: info: Scanning category music_service
Apr 11 13:28:41 volumio volumio[2511]: info: Scanning category plugins.json
Apr 11 13:28:41 volumio volumio[2511]: info: Scanning category system_controller
Apr 11 13:28:41 volumio volumio[2511]: info: Scanning category user_interface
Apr 11 13:28:41 volumio volumio[2511]: info: Scanning into folder /data/plugins/
Apr 11 13:28:41 volumio volumio[2511]: info: Plugin folders cleanup completed
Apr 11 13:28:41 volumio volumio[2511]: info: -------------------------------------------
Apr 11 13:28:41 volumio volumio[2511]: info: ----- Core plugins startup ----
Apr 11 13:28:41 volumio volumio[2511]: info: -------------------------------------------
Apr 11 13:28:41 volumio volumio[2511]: info: Loading plugins from folder /volumio/app/plugins/
Apr 11 13:28:41 volumio volumio[2511]: info: Adding plugin upnp to MyMusic Plugins
Apr 11 13:28:41 volumio volumio[2511]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 11 13:28:41 volumio volumio[2511]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 11 13:28:41 volumio volumio[2511]: info: Loading plugins from folder /data/plugins/
Apr 11 13:28:41 volumio volumio[2511]: info: Loading plugin "system"...
Apr 11 13:28:41 volumio volumio[2511]: info: Loading plugin "appearance"...
Apr 11 13:28:43 volumio volumio[2511]: info: Loading plugin "network"...
Apr 11 13:28:43 volumio volumio[2511]: info: Refreshing Cached IP Addresses
Apr 11 13:28:43 volumio sudo[2570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 11 13:28:43 volumio sudo[2570]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:43 volumio sudo[2570]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:43 volumio sudo[2572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 11 13:28:43 volumio sudo[2572]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:43 volumio sudo[2572]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:43 volumio volumio[2511]: info: Loading plugin "services"...
Apr 11 13:28:43 volumio volumio[2511]: info: Loading plugin "volumio5onboarding"...
Apr 11 13:28:43 volumio sudo[2581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 11 13:28:43 volumio sudo[2581]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:43 volumio volumio[2511]: info: Loading plugin "alsa_controller"...
Apr 11 13:28:43 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 11 13:28:43 volumio volumio[2511]: info: Loading plugin "wizard"...
Apr 11 13:28:43 volumio volumio[2511]: info: Loading plugin "networkfs"...
Apr 11 13:28:43 volumio volumio[2511]: info: Starting Udev Watcher for removable devices
Apr 11 13:28:43 volumio volumio[2511]: info: Ignoring mount for partition: boot
Apr 11 13:28:43 volumio volumio[2511]: info: Ignoring mount for partition: volumio
Apr 11 13:28:43 volumio volumio[2511]: info: Ignoring mount for partition: volumio_data
Apr 11 13:28:43 volumio volumio[2511]: info: Mounting Device Musica
Apr 11 13:28:43 volumio sudo[2601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Musica -o noatime
Apr 11 13:28:43 volumio sudo[2601]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:43 volumio sudo[2601]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:43 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 11 13:28:43 volumio volumio[2511]: info: Loading plugin "volumio_command_line_client"...
Apr 11 13:28:43 volumio volumio[2511]: info: Loading plugin "upnp"...
Apr 11 13:28:43 volumio volumio[2511]: info: [1775906923858] Starting Upmpd Daemon
Apr 11 13:28:43 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 11 13:28:43 volumio volumio[2511]: info: Loading plugin "my_music"...
Apr 11 13:28:43 volumio volumio[2511]: info: Loading plugin "mpd"...
Apr 11 13:28:44 volumio sudo[2581]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:44 volumio volumio[2511]: info: Loading plugin "upnp_browser"...
Apr 11 13:28:45 volumio volumio[2511]: info: Starting UPNP Browser
Apr 11 13:28:45 volumio volumio[2511]: info: Loading plugin "alarm-clock"...
Apr 11 13:28:45 volumio volumio[2511]: info: Loading plugin "airplay_emulation"...
Apr 11 13:28:45 volumio volumio[2511]: info: Starting Shairport Sync
Apr 11 13:28:45 volumio volumio[2511]: info: Loading plugin "last_100"...
Apr 11 13:28:45 volumio volumio[2511]: info: Loading plugin "webradio"...
Apr 11 13:28:45 volumio volumio[2511]: info: Loading plugin "i2s_dacs"...
Apr 11 13:28:45 volumio volumio[2511]: info: Loading plugin "volumiodiscovery"...
Apr 11 13:28:45 volumio volumio[2511]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 11 13:28:45 volumio volumio[2511]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 11 13:28:45 volumio volumio[2511]: *** WARNING *** For more information see
Apr 11 13:28:45 volumio node[2511]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 11 13:28:45 volumio volumio[2511]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 11 13:28:45 volumio volumio[2511]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 11 13:28:45 volumio volumio[2511]: *** WARNING *** For more information see
Apr 11 13:28:45 volumio node[2511]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 11 13:28:45 volumio node[2511]: *** WARNING *** For more information see
Apr 11 13:28:45 volumio node[2511]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 11 13:28:45 volumio node[2511]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 11 13:28:45 volumio node[2511]: *** WARNING *** For more information see
Apr 11 13:28:45 volumio volumio[2511]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 11 13:28:45 volumio volumio[2511]: info: Discovery: Started advertising with name: Volumio
Apr 11 13:28:45 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 11 13:28:45 volumio volumio[2511]: info: Loading plugin "outputs"...
Apr 11 13:28:45 volumio volumio[2511]: info: Loading plugin "albumart"...
Apr 11 13:28:45 volumio volumio[2511]: info: Plugin example_plugin is not enabled
Apr 11 13:28:45 volumio volumio[2511]: info: Loading plugin "inputs"...
Apr 11 13:28:45 volumio volumio[2511]: info: Loading plugin "updater_comm"...
Apr 11 13:28:46 volumio volumio[2511]: info: Plugin mpdemulation is not enabled
Apr 11 13:28:46 volumio volumio[2511]: info: Loading plugin "rest_api"...
Apr 11 13:28:46 volumio volumio[2511]: info: Loading plugin "websocket"...
Apr 11 13:28:46 volumio volumio[2511]: info: Starting Socket.io Server version 2.3.0
Apr 11 13:28:46 volumio volumio[2511]: info: Loading i18n strings for locale it
Apr 11 13:28:46 volumio volumio[2511]: Updating browse sources language
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 13:28:46 volumio volumio[2511]: Forking 3 albumart workers
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::initPlayerControls
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 13:28:46 volumio volumio[2511]: Express server listening on port 3000
Apr 11 13:28:46 volumio volumio[2511]: [Metrics] WebUI: 8s 295.59ms
Apr 11 13:28:46 volumio volumio[2511]: info: CoreStateMachine::resetVolumioState
Apr 11 13:28:46 volumio volumio[2511]: info: CoreStateMachine::getcurrentVolume
Apr 11 13:28:46 volumio volumio[2511]: info: CoreCommandRouter::volumioRetrievevolume
Apr 11 13:28:46 volumio volumio[2511]: info: Cannot read play queue from file
Apr 11 13:28:47 volumio volumio[2511]: info: Volumio Network Manager: Network status updated: 3
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 1
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 2
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 3
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 4
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 5
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 6
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 7
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 8
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 9
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 10
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 11
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 12
Apr 11 13:28:47 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 13
Apr 11 13:28:47 volumio volumio[2511]: info: VolumeController:: Volume=46 Mute =true
Apr 11 13:28:47 volumio volumio[2511]: info: CoreStateMachine::pushState
Apr 11 13:28:47 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:47 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 13:28:47 volumio volumio[2511]: info: CoreCommandRouter::volumioPushState
Apr 11 13:28:47 volumio volumio[2511]: info: CoreStateMachine::updateTrackBlock
Apr 11 13:28:47 volumio volumio[2511]: info: CorePlayQueue::getTrackBlock
Apr 11 13:28:47 volumio volumio[2511]: info: CoreCommandRouter::volumioRetrievevolume
Apr 11 13:28:47 volumio volumio[2511]: info: CoreStateMachine::setRepeat null single undefined
Apr 11 13:28:47 volumio volumio[2511]: info: CoreStateMachine::pushState
Apr 11 13:28:47 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:47 volumio volumio[2511]: info: CoreCommandRouter::volumioPushState
Apr 11 13:28:47 volumio volumio[2511]: info: CoreStateMachine::setRandom null
Apr 11 13:28:47 volumio volumio[2511]: info: CoreStateMachine::pushState
Apr 11 13:28:47 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:47 volumio volumio[2511]: info: CoreCommandRouter::volumioPushState
Apr 11 13:28:47 volumio volumio[2511]: info: Setting Device type: Raspberry PI
Apr 11 13:28:47 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 13
Apr 11 13:28:48 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 14
Apr 11 13:28:48 volumio volumio[2511]: info: Completed loading Core Plugins
Apr 11 13:28:48 volumio volumio[2511]: info: Preparing to generate the ALSA configuration file
Apr 11 13:28:48 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 15
Apr 11 13:28:48 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 16
Apr 11 13:28:48 volumio volumio[2511]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 17
Apr 11 13:28:48 volumio volumio[2511]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 17
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::volumioGetState
Apr 11 13:28:48 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:48 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:48 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:28:48 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 18
Apr 11 13:28:48 volumio volumio[2511]: info: Received Get System Info
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 13:28:48 volumio volumio[2511]: info: Discovery: Getting this device information
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::volumioGetState
Apr 11 13:28:48 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 13:28:48 volumio volumio[2511]: Starting albumart workers
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::volumioGetState
Apr 11 13:28:48 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::volumioGetState
Apr 11 13:28:48 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:48 volumio volumio[2511]: Starting albumart workers
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::volumioGetState
Apr 11 13:28:48 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:48 volumio volumio[2511]: Starting albumart workers
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::volumioGetQueue
Apr 11 13:28:48 volumio volumio[2511]: info: CoreStateMachine::getQueue
Apr 11 13:28:48 volumio volumio[2511]: info: CorePlayQueue::getQueue
Apr 11 13:28:48 volumio volumio[2511]: info: Listing playlists
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 11 13:28:48 volumio volumio[2511]: info: Received Get System Info
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 13:28:48 volumio volumio[2511]: info: Discovery: Getting this device information
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::volumioGetState
Apr 11 13:28:48 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::volumioGetState
Apr 11 13:28:48 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:48 volumio volumio[2511]: info: VolumeController:: Volume=46 Mute =true
Apr 11 13:28:48 volumio volumio[2511]: info: CoreStateMachine::pushState
Apr 11 13:28:48 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::volumioPushState
Apr 11 13:28:48 volumio volumio[2511]: info: Asound.conf file unchanged, so no further update is needed
Apr 11 13:28:48 volumio volumio[2511]: info: Output device has changed, restarting MPD
Apr 11 13:28:48 volumio volumio[2511]: info: Output device has changed, restarting Shairport Sync
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:48 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:28:48 volumio sudo[2650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 11 13:28:48 volumio sudo[2650]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:48 volumio sudo[2650]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:48 volumio sudo[2652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 11 13:28:48 volumio sudo[2652]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:48 volumio volumio[2511]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 11 13:28:48 volumio systemd[1]: Stopping Music Player Daemon...
Apr 11 13:28:48 volumio volumio[2511]: info: ___________ START PLUGINS ___________
Apr 11 13:28:48 volumio systemd[1]: mpd.service: Succeeded.
Apr 11 13:28:48 volumio systemd[1]: Stopped Music Player Daemon.
Apr 11 13:28:48 volumio volumio[2511]: info: ControllerMpd::onStart: Initializing MPD
Apr 11 13:28:48 volumio volumio[2511]: info: Creating MPD Configuration file
Apr 11 13:28:48 volumio systemd[1]: Starting Music Player Daemon...
Apr 11 13:28:48 volumio sudo[2660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Apr 11 13:28:48 volumio sudo[2660]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:49 volumio sudo[2660]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:49 volumio sudo[2664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 11 13:28:49 volumio sudo[2664]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:49 volumio sudo[2664]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:49 volumio volumio[2511]: info: [1775906929140] CoreMusicLibrary::Adding element Server multimediali
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 13:28:49 volumio volumio[2511]: info: UPNP Browser: Client initialized successfully
Apr 11 13:28:49 volumio sudo[2666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 11 13:28:49 volumio sudo[2666]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:28:49 volumio sudo[2659]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 11 13:28:49 volumio sudo[2659]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:49 volumio sudo[2659]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:49 volumio systemd[1]: mpd.service: Succeeded.
Apr 11 13:28:49 volumio systemd[1]: Stopped Music Player Daemon.
Apr 11 13:28:49 volumio systemd[1]: Starting Music Player Daemon...
Apr 11 13:28:49 volumio volumio[2511]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:28:49 volumio volumio[2511]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 11 13:28:49 volumio volumio[2511]: info: [1775906929534] CoreMusicLibrary::Adding element Last_100
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 11 13:28:49 volumio volumio[2511]: info: [1775906929545] CoreMusicLibrary::Adding element Webradio
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 11 13:28:49 volumio volumio[2511]: info: Initializing BBC Radios
Apr 11 13:28:49 volumio sudo[2671]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 11 13:28:49 volumio sudo[2671]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:49 volumio sudo[2671]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 11 13:28:49 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:28:49 volumio volumio[2511]: info: Volumio Calling Home
Apr 11 13:28:50 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:50 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:28:50 volumio volumio[2511]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:28:50 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 19
Apr 11 13:28:50 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:50 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:50 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:50 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:50 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 20
Apr 11 13:28:50 volumio volumio[2511]: info: MPD Permissions set
Apr 11 13:28:50 volumio volumio[2511]: info: MPD Permissions set
Apr 11 13:28:50 volumio volumio[2511]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 21
Apr 11 13:28:51 volumio volumio[2511]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 22
Apr 11 13:28:51 volumio volumio[2511]: info: Volumio called home
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:51 volumio volumio[2511]: info: Starting Shairport Sync
Apr 11 13:28:51 volumio volumio[2511]: info: Starting Shairport Sync
Apr 11 13:28:51 volumio volumio[2511]: info: Starting Shairport Sync
Apr 11 13:28:51 volumio sudo[2726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 11 13:28:51 volumio sudo[2726]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:51 volumio sudo[2728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 11 13:28:51 volumio sudo[2728]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:51 volumio sudo[2732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::volumioGetState
Apr 11 13:28:51 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:28:51 volumio sudo[2732]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:51 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:51 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 11 13:28:51 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 11 13:28:51 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 11 13:28:51 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 11 13:28:51 volumio sudo[2726]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:51 volumio sudo[2728]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:51 volumio sudo[2732]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:51 volumio volumio[2511]: info: Shairport-Sync Started
Apr 11 13:28:51 volumio volumio[2511]: Error adding Membership: Error: addMembership EINVAL
Apr 11 13:28:51 volumio volumio[2511]: info: Shairport-Sync Started
Apr 11 13:28:51 volumio volumio[2511]: info: Shairport-Sync Started
Apr 11 13:28:52 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:52 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:28:52 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:52 volumio mpd[2686]: Apr 11 13:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 11 13:28:52 volumio systemd[1]: Started Music Player Daemon.
Apr 11 13:28:53 volumio sudo[2652]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:53 volumio sudo[2666]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:53 volumio volumio[2511]: info: Completed starting Core Plugins
Apr 11 13:28:53 volumio volumio[2511]: info: -------------------------------------------
Apr 11 13:28:53 volumio volumio[2511]: info: ----- MyVolumio plugins startup ----
Apr 11 13:28:53 volumio volumio[2511]: info: -------------------------------------------
Apr 11 13:28:53 volumio volumio[2511]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 11 13:28:53 volumio volumio[2511]: error: MPD error: The expression evaluated to a falsy value:
Apr 11 13:28:53 volumio volumio[2511]: assert.ok(self.idling)
Apr 11 13:28:53 volumio volumio[2511]: error: The expression evaluated to a falsy value:
Apr 11 13:28:53 volumio volumio[2511]: assert.ok(self.idling)
Apr 11 13:28:53 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:53 volumio volumio[2511]: info: MPD running with PID2686
Apr 11 13:28:53 volumio volumio[2511]: ,establishing connection
Apr 11 13:28:53 volumio volumio[2511]: error: updateQueue error: null
Apr 11 13:28:53 volumio volumio[2511]: error: updateQueue error: null
Apr 11 13:28:53 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:53 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:28:53 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:53 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:28:53 volumio volumio[2511]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:28:53 volumio volumio-remote-updater[616]: [2026-04-11 13:28:53] [connect] Successful connection
Apr 11 13:28:53 volumio volumio-remote-updater[616]: [2026-04-11 13:28:53] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1775906933 101
Apr 11 13:28:53 volumio volumio[2511]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 23
Apr 11 13:28:53 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:53 volumio sudo[2760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 11 13:28:53 volumio sudo[2760]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:53 volumio sudo[2760]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:53 volumio sudo[2762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 11 13:28:53 volumio sudo[2762]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:53 volumio sudo[2762]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:53 volumio sudo[2765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 11 13:28:53 volumio sudo[2765]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:28:54 volumio sudo[2765]: pam_unix(sudo:session): session closed for user root
Apr 11 13:28:54 volumio volumio[2511]: info: Upmpdcli Daemon Started
Apr 11 13:28:54 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:54 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:54 volumio volumio5-onboarding[1524]: time=2026-04-11T13:28:54.626+02:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded"
Apr 11 13:28:55 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:55 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:56 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:56 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:28:56 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:57 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:57 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:58 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:28:59 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:59 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:28:59 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:28:59 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:28:59 volumio volumio[2511]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:29:00 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Apr 11 13:29:01 volumio volumio[2511]: info: Adding plugin bluetooth to MyMusic Plugins
Apr 11 13:29:01 volumio volumio[2511]: info: Adding plugin multiroom to MyMusic Plugins
Apr 11 13:29:01 volumio volumio[2511]: info: Adding plugin metavolumio to MyMusic Plugins
Apr 11 13:29:01 volumio volumio[2511]: info: Adding plugin cd_controller to MyMusic Plugins
Apr 11 13:29:01 volumio volumio[2511]: info: Adding plugin qobuzconnect to MyMusic Plugins
Apr 11 13:29:01 volumio volumio[2511]: info: Adding plugin smart_inputs to MyMusic Plugins
Apr 11 13:29:01 volumio volumio[2511]: info: Adding plugin tidalconnect to MyMusic Plugins
Apr 11 13:29:01 volumio volumio[2511]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Apr 11 13:29:03 volumio volumio[2511]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Apr 11 13:29:03 volumio volumio[2511]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Apr 11 13:29:03 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:03 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:03 volumio volumio[2511]: info: Starting MyVolumio Remote Streaming Endpoints
Apr 11 13:29:03 volumio volumio[2511]: info: MyVolumio login type: Token
Apr 11 13:29:03 volumio volumio[2511]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Apr 11 13:29:03 volumio volumio[2511]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Apr 11 13:29:05 volumio volumio[2511]: info: Starting Streaming Service Transparent Proxy
Apr 11 13:29:05 volumio volumio[2511]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Apr 11 13:29:05 volumio volumio[2511]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Apr 11 13:29:05 volumio volumio[2511]: info: Streaming services startup
Apr 11 13:29:05 volumio volumio[2511]: info: Starting Streaming Daemon
Apr 11 13:29:05 volumio sudo[2792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 11 13:29:05 volumio sudo[2792]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:05 volumio volumio[2511]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Apr 11 13:29:05 volumio sudo[2792]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:06 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:29:06 volumio volumio[2511]: error: Cannot start Volumio Streaming Daemon
Apr 11 13:29:06 volumio volumio[2511]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 11 13:29:06 volumio volumio[2511]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 11 13:29:06 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:06 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:06 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:06 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:06 volumio volumio[2511]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:29:06 volumio volumio[2511]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Apr 11 13:29:07 volumio volumio[2511]: STREAMING PROXY: Starting server on port 3245
Apr 11 13:29:07 volumio volumio[2511]: Node JS runtime: 14
Apr 11 13:29:08 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:29:08 volumio volumio[2511]: info: MyVolumio token set successfully
Apr 11 13:29:08 volumio volumio[2511]: info: MYVOLUMIO: Adding device
Apr 11 13:29:08 volumio volumio[2511]: info: MYVOLUMIO: Evaluating Server
Apr 11 13:29:09 volumio volumio[2511]: info: MyVolumio status changed
Apr 11 13:29:09 volumio volumio[2511]: info: Streaming services startup
Apr 11 13:29:09 volumio volumio[2511]: info: Starting Streaming Daemon
Apr 11 13:29:09 volumio volumio[2511]: info: Removing browser output: myVolumio user plan is not superstar
Apr 11 13:29:09 volumio volumio[2511]: info: Removing audio output:
Apr 11 13:29:09 volumio volumio[2511]: info: Stoppping Tunnel 1
Apr 11 13:29:09 volumio sudo[2823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 11 13:29:09 volumio sudo[2823]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:09 volumio sudo[2823]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:09 volumio volumio[2511]: error: Cannot start Volumio Streaming Daemon
Apr 11 13:29:09 volumio sudo[2826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Apr 11 13:29:09 volumio volumio[2511]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 11 13:29:09 volumio volumio[2511]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 11 13:29:09 volumio sudo[2826]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:09 volumio sudo[2826]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:09 volumio volumio[2511]: info: Remote SSH Stopped
Apr 11 13:29:09 volumio volumio[2511]: info: Setting Geolocation for MyVolumio to eu7
Apr 11 13:29:09 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:09 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:09 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:09 volumio volumio[2511]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Apr 11 13:29:10 volumio volumio[2511]: info: Updating MyVolumio device info
Apr 11 13:29:10 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:10 volumio volumio[2511]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Apr 11 13:29:11 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:11 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:11 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:11 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:11 volumio volumio[2511]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:29:12 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:29:13 volumio volumio[2511]: info: MYVOLUMIO: Adding device
Apr 11 13:29:13 volumio volumio[2511]: info: MYVOLUMIO: Evaluating Server
Apr 11 13:29:14 volumio volumio[2511]: info: Setting Geolocation for MyVolumio to eu7
Apr 11 13:29:14 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:15 volumio volumio[2511]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Apr 11 13:29:15 volumio volumio[2511]: info: Updating MyVolumio device info
Apr 11 13:29:15 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:15 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:15 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:16 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:29:16 volumio volumio[2511]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Apr 11 13:29:16 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:16 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:16 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:16 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:16 volumio volumio[2511]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:29:18 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 11 13:29:18 volumio volumio[2511]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
Apr 11 13:29:18 volumio volumio[2511]: info: CoreCommandRouter::volumioGetState
Apr 11 13:29:18 volumio volumio[2511]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:19 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 11 13:29:19 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:19 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 11 13:29:19 volumio volumio-remote-updater[616]: No test mode
Apr 11 13:29:19 volumio volumio-remote-updater[616]: No alpha test mode
Apr 11 13:29:19 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Apr 11 13:29:20 volumio volumio[2511]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Apr 11 13:29:20 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 11 13:29:20 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:29:21 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:21 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:21 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:21 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:21 volumio volumio[2511]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:29:23 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:23 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:23 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Apr 11 13:29:23 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 11 13:29:23 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Apr 11 13:29:23 volumio volumio[2511]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 11 13:29:23 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 11 13:29:24 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:29:25 volumio volumio[2511]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Apr 11 13:29:25 volumio volumio[2511]: info: Completed starting MyVolumio Plugin
Apr 11 13:29:25 volumio volumio[2511]: [Metrics] CommandRouter: 46s 306.10ms
Apr 11 13:29:25 volumio volumio[2511]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 11 13:29:25 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:25 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:25 volumio volumio[2511]: info: CoreCommandRouter::Close All Modals sent
Apr 11 13:29:26 volumio volumio[2511]: info: CoreCommandRouter::Close All Modals sent
Apr 11 13:29:26 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:26 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:26 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:26 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:26 volumio volumio[2511]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:29:27 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 11 13:29:27 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 11 13:29:27 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 11 13:29:28 volumio volumio[2511]: info: CALLMETHOD: miscellanea albumart saveAlbumartOptions [object Object]
Apr 11 13:29:28 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: albumart , saveAlbumartOptions
Apr 11 13:29:28 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:29:31 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:31 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:31 volumio volumio[2511]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:31 volumio volumio[2511]: info: Discovery: Restarting Browsing
Apr 11 13:29:31 volumio volumio[2511]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:29:32 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:29:33 volumio volumio[2511]: info: BOOT COMPLETED
Apr 11 13:29:33 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Apr 11 13:29:33 volumio volumio[2511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Apr 11 13:29:33 volumio volumio[2511]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 13:29:33 volumio volumio[2511]: Error: getaddrinfo -3007
Apr 11 13:29:33 volumio volumio[2511]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Apr 11 13:29:33 volumio volumio[2511]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Apr 11 13:29:33 volumio volumio[2511]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Apr 11 13:29:33 volumio volumio[2511]: code: -3007,
Apr 11 13:29:33 volumio volumio[2511]: errno: -3007,
Apr 11 13:29:33 volumio volumio[2511]: syscall: 'getaddrinfo'
Apr 11 13:29:33 volumio volumio[2511]: }
Apr 11 13:29:33 volumio volumio[2511]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 13:29:34 volumio sudo[2922]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-11 13:28
Apr 11 13:29:34 volumio sudo[2922]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:34 volumio sudo[2922]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:34 volumio volumio5-onboarding[1524]: time=2026-04-11T13:29:34.915+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF"
Apr 11 13:29:34 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 11 13:29:34 volumio volumio-remote-updater[616]: [2026-04-11 13:29:34] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 11 13:29:34 volumio volumio-remote-updater[616]: [2026-04-11 13:29:34] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 11 13:29:34 volumio systemd[1]: media-Musica.mount: Succeeded.
Apr 11 13:29:34 volumio volumio5-onboarding[1524]: time=2026-04-11T13:29:34.950+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 11 13:29:34 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 11 13:29:35 volumio systemd[1]: Started dynamicswap service.
Apr 11 13:29:35 volumio systemd[1]: dynamicswap.service: Succeeded.
Apr 11 13:29:35 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 11 13:29:35 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2.
Apr 11 13:29:35 volumio systemd[1]: Stopped Volumio Backend Module.
Apr 11 13:29:35 volumio systemd[1]: Started Volumio Backend Module.
Apr 11 13:29:35 volumio systemd[1]: Started dynamicswap service.
Apr 11 13:29:35 volumio systemd[1]: dynamicswap.service: Succeeded.
Apr 11 13:29:35 volumio volumio5-onboarding[1524]: time=2026-04-11T13:29:35.954+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 11 13:29:36 volumio volumio5-onboarding[1524]: time=2026-04-11T13:29:36.957+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 11 13:29:38 volumio volumio[2933]: info: -------------------------------------------
Apr 11 13:29:38 volumio volumio[2933]: info: ----- Volumio3 ----
Apr 11 13:29:38 volumio volumio[2933]: info: -------------------------------------------
Apr 11 13:29:38 volumio volumio[2933]: info: ----- System startup ----
Apr 11 13:29:38 volumio volumio[2933]: info: -------------------------------------------
Apr 11 13:29:39 volumio volumio[2933]: info: MYVOLUMIO Environment detected
Apr 11 13:29:39 volumio volumio[2933]: info: Plugin folders cleanup
Apr 11 13:29:39 volumio volumio[2933]: info: Scanning into folder /volumio/app/plugins/
Apr 11 13:29:39 volumio volumio[2933]: info: Scanning category audio_interface
Apr 11 13:29:39 volumio volumio-remote-updater[616]: [2026-04-11 13:29:39] [connect] Successful connection
Apr 11 13:29:39 volumio volumio[2933]: info: Scanning category miscellanea
Apr 11 13:29:39 volumio volumio[2933]: info: Scanning category music_service
Apr 11 13:29:39 volumio volumio[2933]: info: Scanning category plugins.json
Apr 11 13:29:39 volumio volumio[2933]: info: Scanning category system_controller
Apr 11 13:29:39 volumio volumio[2933]: info: Scanning category user_interface
Apr 11 13:29:39 volumio volumio[2933]: info: Scanning into folder /data/plugins/
Apr 11 13:29:39 volumio volumio[2933]: info: Plugin folders cleanup completed
Apr 11 13:29:39 volumio volumio[2933]: info: -------------------------------------------
Apr 11 13:29:39 volumio volumio[2933]: info: ----- Core plugins startup ----
Apr 11 13:29:39 volumio volumio[2933]: info: -------------------------------------------
Apr 11 13:29:39 volumio volumio[2933]: info: Loading plugins from folder /volumio/app/plugins/
Apr 11 13:29:39 volumio volumio[2933]: info: Adding plugin upnp to MyMusic Plugins
Apr 11 13:29:39 volumio volumio[2933]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 11 13:29:39 volumio volumio[2933]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 11 13:29:39 volumio volumio[2933]: info: Loading plugins from folder /data/plugins/
Apr 11 13:29:39 volumio volumio[2933]: info: Loading plugin "system"...
Apr 11 13:29:40 volumio volumio[2933]: info: Loading plugin "appearance"...
Apr 11 13:29:41 volumio volumio[2933]: info: Loading plugin "network"...
Apr 11 13:29:41 volumio volumio[2933]: info: Refreshing Cached IP Addresses
Apr 11 13:29:41 volumio sudo[2998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 11 13:29:41 volumio sudo[2998]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:41 volumio sudo[2998]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:41 volumio sudo[3000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 11 13:29:41 volumio sudo[3000]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:41 volumio sudo[3000]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:41 volumio volumio[2933]: info: Loading plugin "services"...
Apr 11 13:29:42 volumio volumio[2933]: info: Loading plugin "volumio5onboarding"...
Apr 11 13:29:42 volumio sudo[3013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 11 13:29:42 volumio sudo[3013]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:42 volumio volumio[2933]: info: Loading plugin "alsa_controller"...
Apr 11 13:29:42 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 11 13:29:42 volumio volumio[2933]: info: Loading plugin "wizard"...
Apr 11 13:29:42 volumio volumio[2933]: info: Loading plugin "networkfs"...
Apr 11 13:29:42 volumio volumio[2933]: info: Starting Udev Watcher for removable devices
Apr 11 13:29:42 volumio volumio[2933]: info: Ignoring mount for partition: boot
Apr 11 13:29:42 volumio volumio[2933]: info: Ignoring mount for partition: volumio
Apr 11 13:29:42 volumio volumio[2933]: info: Ignoring mount for partition: volumio_data
Apr 11 13:29:42 volumio volumio[2933]: info: Mounting Device Musica
Apr 11 13:29:42 volumio sudo[3029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Musica -o noatime
Apr 11 13:29:42 volumio sudo[3029]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:42 volumio sudo[3029]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:42 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 11 13:29:42 volumio volumio[2933]: info: Loading plugin "volumio_command_line_client"...
Apr 11 13:29:42 volumio volumio[2933]: info: Loading plugin "upnp"...
Apr 11 13:29:42 volumio volumio[2933]: info: [1775906982646] Starting Upmpd Daemon
Apr 11 13:29:42 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 11 13:29:42 volumio volumio[2933]: info: Loading plugin "my_music"...
Apr 11 13:29:42 volumio volumio[2933]: info: Loading plugin "mpd"...
Apr 11 13:29:43 volumio sudo[3013]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:43 volumio volumio[2933]: info: Loading plugin "upnp_browser"...
Apr 11 13:29:43 volumio volumio[2933]: info: Starting UPNP Browser
Apr 11 13:29:43 volumio volumio[2933]: info: Loading plugin "alarm-clock"...
Apr 11 13:29:44 volumio volumio[2933]: info: Loading plugin "airplay_emulation"...
Apr 11 13:29:44 volumio volumio[2933]: info: Starting Shairport Sync
Apr 11 13:29:44 volumio volumio[2933]: info: Loading plugin "last_100"...
Apr 11 13:29:44 volumio volumio[2933]: info: Loading plugin "webradio"...
Apr 11 13:29:44 volumio volumio[2933]: info: Loading plugin "i2s_dacs"...
Apr 11 13:29:44 volumio volumio[2933]: info: Loading plugin "volumiodiscovery"...
Apr 11 13:29:44 volumio volumio[2933]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 11 13:29:44 volumio volumio[2933]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 11 13:29:44 volumio volumio[2933]: *** WARNING *** For more information see
Apr 11 13:29:44 volumio node[2933]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 11 13:29:44 volumio volumio[2933]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 11 13:29:44 volumio volumio[2933]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 11 13:29:44 volumio volumio[2933]: *** WARNING *** For more information see
Apr 11 13:29:44 volumio node[2933]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 11 13:29:44 volumio node[2933]: *** WARNING *** For more information see
Apr 11 13:29:44 volumio node[2933]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 11 13:29:44 volumio node[2933]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 11 13:29:44 volumio node[2933]: *** WARNING *** For more information see
Apr 11 13:29:44 volumio volumio[2933]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 11 13:29:44 volumio volumio[2933]: info: Discovery: Started advertising with name: Volumio
Apr 11 13:29:44 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 11 13:29:44 volumio volumio[2933]: info: Loading plugin "outputs"...
Apr 11 13:29:44 volumio volumio[2933]: info: Loading plugin "albumart"...
Apr 11 13:29:44 volumio volumio[2933]: info: Plugin example_plugin is not enabled
Apr 11 13:29:44 volumio volumio[2933]: info: Loading plugin "inputs"...
Apr 11 13:29:44 volumio volumio[2933]: info: Loading plugin "updater_comm"...
Apr 11 13:29:45 volumio volumio[2933]: info: Plugin mpdemulation is not enabled
Apr 11 13:29:45 volumio volumio[2933]: info: Loading plugin "rest_api"...
Apr 11 13:29:45 volumio volumio[2933]: info: Loading plugin "websocket"...
Apr 11 13:29:45 volumio volumio[2933]: info: Starting Socket.io Server version 2.3.0
Apr 11 13:29:45 volumio volumio[2933]: info: Loading i18n strings for locale it
Apr 11 13:29:45 volumio volumio[2933]: Updating browse sources language
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 13:29:45 volumio volumio[2933]: Forking 3 albumart workers
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::initPlayerControls
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 13:29:45 volumio volumio[2933]: Express server listening on port 3000
Apr 11 13:29:45 volumio volumio[2933]: [Metrics] WebUI: 8s 188.38ms
Apr 11 13:29:45 volumio volumio[2933]: info: CoreStateMachine::resetVolumioState
Apr 11 13:29:45 volumio volumio[2933]: info: CoreStateMachine::getcurrentVolume
Apr 11 13:29:45 volumio volumio[2933]: info: CoreCommandRouter::volumioRetrievevolume
Apr 11 13:29:45 volumio volumio[2933]: info: Cannot read play queue from file
Apr 11 13:29:45 volumio volumio[2933]: info: Volumio Network Manager: Network status updated: 3
Apr 11 13:29:45 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 1
Apr 11 13:29:45 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 2
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 4
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 5
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 6
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 7
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 8
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 9
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 10
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 11
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 11
Apr 11 13:29:46 volumio volumio[2933]: info: Received Get System Info
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 13:29:46 volumio volumio[2933]: info: Discovery: Getting this device information
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::volumioGetState
Apr 11 13:29:46 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 12
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 13
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 11 13:29:46 volumio volumio[2933]: info: VolumeController:: Volume=46 Mute =true
Apr 11 13:29:46 volumio volumio[2933]: info: CoreStateMachine::pushState
Apr 11 13:29:46 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::volumioPushState
Apr 11 13:29:46 volumio volumio[2933]: info: CoreStateMachine::updateTrackBlock
Apr 11 13:29:46 volumio volumio[2933]: info: CorePlayQueue::getTrackBlock
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::volumioRetrievevolume
Apr 11 13:29:46 volumio volumio[2933]: info: CoreStateMachine::setRepeat null single undefined
Apr 11 13:29:46 volumio volumio[2933]: info: CoreStateMachine::pushState
Apr 11 13:29:46 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::volumioPushState
Apr 11 13:29:46 volumio volumio[2933]: info: CoreStateMachine::setRandom null
Apr 11 13:29:46 volumio volumio[2933]: info: CoreStateMachine::pushState
Apr 11 13:29:46 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:46 volumio volumio[2933]: info: CoreCommandRouter::volumioPushState
Apr 11 13:29:46 volumio volumio[2933]: info: Setting Device type: Raspberry PI
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 14
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 15
Apr 11 13:29:46 volumio volumio[2933]: info: Completed loading Core Plugins
Apr 11 13:29:46 volumio volumio[2933]: info: Preparing to generate the ALSA configuration file
Apr 11 13:29:46 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 16
Apr 11 13:29:47 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 17
Apr 11 13:29:47 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 18
Apr 11 13:29:47 volumio volumio[2933]: info: Asound.conf file unchanged, so no further update is needed
Apr 11 13:29:47 volumio volumio[2933]: info: Output device has changed, restarting MPD
Apr 11 13:29:47 volumio sudo[3078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 11 13:29:47 volumio volumio[2933]: info: Output device has changed, restarting Shairport Sync
Apr 11 13:29:47 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:47 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:47 volumio sudo[3078]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:47 volumio sudo[3078]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:47 volumio sudo[3080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 11 13:29:47 volumio sudo[3080]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:47 volumio volumio[2933]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 11 13:29:47 volumio volumio[2933]: info: ___________ START PLUGINS ___________
Apr 11 13:29:47 volumio systemd[1]: Stopping Music Player Daemon...
Apr 11 13:29:47 volumio volumio[2933]: Starting albumart workers
Apr 11 13:29:47 volumio volumio[2933]: info: ControllerMpd::onStart: Initializing MPD
Apr 11 13:29:47 volumio volumio[2933]: info: Creating MPD Configuration file
Apr 11 13:29:47 volumio systemd[1]: mpd.service: Succeeded.
Apr 11 13:29:47 volumio systemd[1]: Stopped Music Player Daemon.
Apr 11 13:29:47 volumio sudo[3087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Apr 11 13:29:47 volumio sudo[3087]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:47 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 13:29:47 volumio volumio[2933]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 11 13:29:47 volumio volumio[2933]: info: [1775906987441] CoreMusicLibrary::Adding element Server multimediali
Apr 11 13:29:47 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 13:29:47 volumio systemd[1]: Starting Music Player Daemon...
Apr 11 13:29:47 volumio sudo[3091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 11 13:29:47 volumio sudo[3091]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:47 volumio sudo[3093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 11 13:29:47 volumio sudo[3087]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:47 volumio sudo[3093]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:47 volumio volumio[2933]: info: UPNP Browser: Client initialized successfully
Apr 11 13:29:47 volumio volumio[2933]: Starting albumart workers
Apr 11 13:29:47 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:47 volumio sudo[3091]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:47 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:47 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Apr 11 13:29:47 volumio systemd[1]: mpd.service: Succeeded.
Apr 11 13:29:47 volumio systemd[1]: Stopped Music Player Daemon.
Apr 11 13:29:47 volumio volumio5-onboarding[1524]: time=2026-04-11T13:29:47.633+02:00 level=INFO msg="service successfully established" component=discovery/localnet
Apr 11 13:29:47 volumio volumio[2933]: Starting albumart workers
Apr 11 13:29:47 volumio systemd[1]: Starting Music Player Daemon...
Apr 11 13:29:47 volumio volumio[2933]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 11 13:29:47 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:47 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:47 volumio sudo[3096]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 11 13:29:47 volumio sudo[3096]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:47 volumio volumio[2933]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 11 13:29:47 volumio volumio[2933]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 11 13:29:47 volumio volumio[2933]: info: [1775906987984] CoreMusicLibrary::Adding element Last_100
Apr 11 13:29:47 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 13:29:47 volumio sudo[3096]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:48 volumio volumio[2933]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 11 13:29:48 volumio volumio[2933]: info: [1775906988001] CoreMusicLibrary::Adding element Webradio
Apr 11 13:29:48 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 13:29:48 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 11 13:29:48 volumio volumio[2933]: info: Initializing BBC Radios
Apr 11 13:29:48 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 11 13:29:48 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:48 volumio volumio[2933]: info: Volumio Calling Home
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::volumioGetState
Apr 11 13:29:49 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:49 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 19
Apr 11 13:29:49 volumio volumio[2933]: info: VolumeController:: Volume=46 Mute =true
Apr 11 13:29:49 volumio volumio[2933]: info: CoreStateMachine::pushState
Apr 11 13:29:49 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::volumioPushState
Apr 11 13:29:49 volumio volumio[2933]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:49 volumio volumio[2933]: info: Discovery: Restarting Browsing
Apr 11 13:29:49 volumio volumio[2933]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Apr 11 13:29:49 volumio volumio[2933]: info: Discovery: Restarting Browsing
Apr 11 13:29:49 volumio volumio[2933]: info: Discovery: Restart already pending, ignoring duplicate call
Apr 11 13:29:49 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 20
Apr 11 13:29:49 volumio volumio[2933]: info: Received Get System Info
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 13:29:49 volumio volumio[2933]: info: Discovery: Getting this device information
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::volumioGetState
Apr 11 13:29:49 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::volumioGetState
Apr 11 13:29:49 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::volumioGetState
Apr 11 13:29:49 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::volumioGetState
Apr 11 13:29:49 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::volumioGetQueue
Apr 11 13:29:49 volumio volumio[2933]: info: CoreStateMachine::getQueue
Apr 11 13:29:49 volumio volumio[2933]: info: CorePlayQueue::getQueue
Apr 11 13:29:49 volumio volumio[2933]: info: Listing playlists
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 11 13:29:49 volumio volumio[2933]: info: Received Get System Info
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 13:29:49 volumio volumio[2933]: info: Discovery: Getting this device information
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::volumioGetState
Apr 11 13:29:49 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::volumioGetState
Apr 11 13:29:49 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: MPD Permissions set
Apr 11 13:29:49 volumio volumio[2933]: info: MPD Permissions set
Apr 11 13:29:49 volumio volumio[2933]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.7.4 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 21
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:49 volumio volumio[2933]: info: Volumio called home
Apr 11 13:29:49 volumio volumio[2933]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 22
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 13:29:49 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 13:29:50 volumio volumio[2933]: info: Starting Shairport Sync
Apr 11 13:29:50 volumio volumio[2933]: info: Starting Shairport Sync
Apr 11 13:29:50 volumio volumio[2933]: info: Starting Shairport Sync
Apr 11 13:29:50 volumio sudo[3152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 11 13:29:50 volumio sudo[3152]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:50 volumio sudo[3154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 11 13:29:50 volumio sudo[3154]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:50 volumio volumio[2933]: info: CoreCommandRouter::volumioGetState
Apr 11 13:29:50 volumio volumio[2933]: info: CorePlayQueue::getTrack 0
Apr 11 13:29:50 volumio sudo[3157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 11 13:29:50 volumio sudo[3157]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 13:29:50 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:50 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 11 13:29:50 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 11 13:29:50 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 11 13:29:50 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 11 13:29:50 volumio sudo[3152]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:50 volumio sudo[3154]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:50 volumio volumio[2933]: info: Shairport-Sync Started
Apr 11 13:29:50 volumio volumio[2933]: Error adding Membership: Error: addMembership EINVAL
Apr 11 13:29:50 volumio volumio[2933]: info: Shairport-Sync Started
Apr 11 13:29:50 volumio sudo[3157]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:50 volumio volumio[2933]: info: Shairport-Sync Started
Apr 11 13:29:50 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 11 13:29:51 volumio volumio[2933]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Apr 11 13:29:51 volumio mpd[3104]: Apr 11 13:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 11 13:29:51 volumio volumio[2933]: verbose: ControllerMpd::sendMpdCommand rescan
Apr 11 13:29:51 volumio volumio[2933]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 13:29:51 volumio volumio[2933]: TypeError: Cannot read property 'then' of undefined
Apr 11 13:29:51 volumio volumio[2933]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:332:6)
Apr 11 13:29:51 volumio volumio[2933]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1899:15)
Apr 11 13:29:51 volumio volumio[2933]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32)
Apr 11 13:29:51 volumio volumio[2933]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1098:26)
Apr 11 13:29:51 volumio volumio[2933]: at Socket.emit (events.js:315:20)
Apr 11 13:29:51 volumio volumio[2933]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Apr 11 13:29:51 volumio volumio[2933]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Apr 11 13:29:51 volumio volumio[2933]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 13:29:51 volumio systemd[1]: Started Music Player Daemon.
Apr 11 13:29:51 volumio sudo[3093]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:51 volumio sudo[3080]: pam_unix(sudo:session): session closed for user root
Apr 11 13:29:52 volumio volumio-remote-updater[616]: [2026-04-11 13:29:52] [connect] Successful connection
Apr 11 13:29:52 volumio sudo[3189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-11 13:28
Apr 11 13:29:52 volumio sudo[3189]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET"
VOLUMIO_VERSION="3.912"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"