Aug 31 19:17:55 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Aug 31 19:17:55 ferrum-broen volumio[1357]: info: CoreCommandRouter::Reload Ui Aug 31 19:17:55 ferrum-broen sudo[3197]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 19:17:55 ferrum-broen sudo[3197]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:17:55 ferrum-broen sudo[3197]: pam_unix(sudo:session): session closed for user root Aug 31 19:17:55 ferrum-broen sudo[3199]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 19:17:55 ferrum-broen sudo[3199]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:17:55 ferrum-broen sudo[3199]: pam_unix(sudo:session): session closed for user root Aug 31 19:17:55 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 192.168.0.50 from 192.168.0.61 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Edg/152.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Aug 31 19:17:56 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 7 Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:17:56 ferrum-broen volumio-remote-updater[987]: Test mode disabled Aug 31 19:17:56 ferrum-broen volumio-remote-updater[987]: Alpha mode enabled Aug 31 19:17:56 ferrum-broen volumio-remote-updater[987]: Alpha legacy test mode disabled Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Retrieving Cloud Streaming UI Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Getting Tidal Cloud Configuration Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Getting Qobuz Cloud Configuration Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Asking plugin for UI Config Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Getting Spotify Cloud Configuration Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Asking plugin for UI Config Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Saving Spotify Acccount Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Got it Aug 31 19:17:56 ferrum-broen volumio[1357]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Got Tidal Cloud Configuration Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Got it Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:17:56 ferrum-broen volumio-remote-updater[987]: Test mode disabled Aug 31 19:17:56 ferrum-broen volumio-remote-updater[987]: Alpha mode enabled Aug 31 19:17:56 ferrum-broen volumio-remote-updater[987]: Alpha legacy test mode disabled Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Retrieving Cloud Streaming UI Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Getting Tidal Cloud Configuration Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Getting Qobuz Cloud Configuration Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Asking plugin for UI Config Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Getting Spotify Cloud Configuration Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Asking plugin for UI Config Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Saving Spotify Acccount Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Got it Aug 31 19:17:56 ferrum-broen volumio[1357]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Got Tidal Cloud Configuration Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Got it Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:17:56 ferrum-broen volumio[1357]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 31 19:17:56 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 31 19:17:57 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Aug 31 19:17:57 ferrum-broen volumio[1357]: info: Loading i18n strings for locale en Aug 31 19:17:57 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Aug 31 19:17:57 ferrum-broen volumio[1357]: info: Setting timezone to Europe/Warsaw Aug 31 19:17:57 ferrum-broen sudo[3235]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Aug 31 19:17:57 ferrum-broen sudo[3235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:17:57 ferrum-broen sudo[3235]: pam_unix(sudo:session): session closed for user root Aug 31 19:17:57 ferrum-broen sudo[3239]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Aug 31 19:17:57 ferrum-broen sudo[3239]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:17:57 ferrum-broen sudo[3239]: pam_unix(sudo:session): session closed for user root Aug 31 19:17:57 ferrum-broen sudo[3243]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Aug 31 19:17:57 ferrum-broen sudo[3243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:17:57 ferrum-broen sudo[3243]: pam_unix(sudo:session): session closed for user root Aug 31 19:17:57 ferrum-broen sudo[3247]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Aug 31 19:17:57 ferrum-broen sudo[3247]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:17:57 ferrum-broen dbus-daemon[954]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.33' (uid=0 pid=3248 comm="/usr/bin/timedatectl set-timezone Europe/Warsaw") Aug 31 19:17:57 ferrum-broen systemd[1]: Starting systemd-timedated.service - Time & Date Service... Aug 31 19:17:57 ferrum-broen dbus-daemon[954]: [system] Successfully activated service 'org.freedesktop.timedate1' Aug 31 19:17:57 ferrum-broen systemd[1]: Started systemd-timedated.service - Time & Date Service. Aug 31 19:17:57 ferrum-broen sudo[3247]: pam_unix(sudo:session): session closed for user root Aug 31 19:17:57 ferrum-broen volumio[1357]: Updating browse sources language Aug 31 19:17:57 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:17:57 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Aug 31 19:17:57 ferrum-broen volumio[1357]: info: Loading i18n strings for locale en Aug 31 19:17:57 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Aug 31 19:17:57 ferrum-broen volumio[1357]: info: Setting timezone to Europe/Warsaw Aug 31 19:17:57 ferrum-broen sudo[3252]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Aug 31 19:17:57 ferrum-broen sudo[3252]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:17:57 ferrum-broen sudo[3252]: pam_unix(sudo:session): session closed for user root Aug 31 19:17:57 ferrum-broen sudo[3256]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Aug 31 19:17:57 ferrum-broen sudo[3256]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:17:57 ferrum-broen sudo[3256]: pam_unix(sudo:session): session closed for user root Aug 31 19:17:57 ferrum-broen sudo[3260]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Aug 31 19:17:57 ferrum-broen sudo[3260]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:17:57 ferrum-broen sudo[3260]: pam_unix(sudo:session): session closed for user root Aug 31 19:17:57 ferrum-broen sudo[3265]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Aug 31 19:17:57 ferrum-broen sudo[3265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:17:57 ferrum-broen sudo[3265]: pam_unix(sudo:session): session closed for user root Aug 31 19:17:57 ferrum-broen volumio[1357]: Updating browse sources language Aug 31 19:17:57 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:17:57 ferrum-broen volumio[1357]: info: Fetching Streaming Services browse cache Aug 31 19:17:57 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:17:57 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:17:57.867+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.56:42192 Aug 31 19:17:57 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:17:57 ferrum-broen volumio[1357]: info: Fetching Streaming Services browse cache Aug 31 19:17:58 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:17:58 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:17:59 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:17:59.967+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=720.246263ms timeout=10s from=APP_PAGE_SETUP_V1_UPDATE to=APP_PAGE_LEGACY_DEVICE Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.237+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.307+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=http://pushupdates.volumio.org duration=68.59963ms Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.399+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=161.497092ms Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.484+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=246.116703ms Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.529+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=https://www.googleapis.com duration=291.422908ms Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.549+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=310.477592ms Aug 31 19:18:00 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:00 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:00 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:00 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:00 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:00 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.583+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=https://functions.volumio.cloud duration=344.133111ms Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.585+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=https://functions.volumio.cloud duration=346.76024ms Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.593+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=355.082297ms Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.597+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=https://securetoken.googleapis.com duration=358.609556ms Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.705+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=http://cddb.volumio.org duration=466.726759ms Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.727+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=https://database.volumio.cloud duration=488.155518ms Aug 31 19:18:00 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:00.916+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=http://plugins.volumio.org duration=677.727944ms Aug 31 19:18:01 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:01.160+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=866.512115ms timeout=10s endpoint=https://google.com duration=922.032352ms Aug 31 19:18:01 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 192.168.0.50:3000 from 192.168.0.56 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Aug 31 19:18:01 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 19:18:01 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 19:18:03 ferrum-broen sudo[3279]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 19:18:03 ferrum-broen sudo[3279]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:03 ferrum-broen sudo[3279]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:03 ferrum-broen sudo[3281]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 19:18:03 ferrum-broen sudo[3281]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:03 ferrum-broen sudo[3281]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:03 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 192.168.0.50 from 192.168.0.56 UA: Mozilla/5.0 (Linux; Android 13; ASUS_I006D Build/TKQ1.220807.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:04 ferrum-broen volumio-remote-updater[987]: Test mode disabled Aug 31 19:18:04 ferrum-broen volumio-remote-updater[987]: Alpha mode enabled Aug 31 19:18:04 ferrum-broen volumio-remote-updater[987]: Alpha legacy test mode disabled Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Retrieving Cloud Streaming UI Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Getting Tidal Cloud Configuration Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Getting Qobuz Cloud Configuration Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Asking plugin for UI Config Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Getting Spotify Cloud Configuration Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Asking plugin for UI Config Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Saving Spotify Acccount Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Got it Aug 31 19:18:04 ferrum-broen volumio[1357]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Got it Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Got Tidal Cloud Configuration Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:04 ferrum-broen volumio[1357]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 31 19:18:04 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.516+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=703.623853ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.619+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.641+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=21.754555ms Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.642+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=22.361408ms Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.644+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=http://pushupdates.volumio.org duration=24.869908ms Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.653+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=34.041592ms Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.723+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=https://www.googleapis.com duration=104.155463ms Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.747+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=https://securetoken.googleapis.com duration=128.335574ms Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.755+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=136.127907ms Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.762+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=https://database.volumio.cloud duration=143.178945ms Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.763+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=https://functions.volumio.cloud duration=144.488389ms Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.815+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=http://cddb.volumio.org duration=195.563203ms Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.895+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=https://functions.volumio.cloud duration=275.533574ms Aug 31 19:18:04 ferrum-broen sudo[3290]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 19:18:04 ferrum-broen sudo[3290]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:04 ferrum-broen sudo[3290]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:04 ferrum-broen sudo[3292]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 19:18:04 ferrum-broen sudo[3292]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:04 ferrum-broen sudo[3292]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:04 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:04.936+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=http://plugins.volumio.org duration=317.277352ms Aug 31 19:18:05 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 192.168.0.50 from 192.168.0.56 UA: Mozilla/5.0 (Linux; Android 13; ASUS_I006D Build/TKQ1.220807.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 31 19:18:05 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:05.242+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.56:47816,00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" latency=697.118279ms timeout=10s endpoint=https://google.com duration=622.932555ms Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:05 ferrum-broen volumio-remote-updater[987]: Test mode disabled Aug 31 19:18:05 ferrum-broen volumio-remote-updater[987]: Alpha mode enabled Aug 31 19:18:05 ferrum-broen volumio-remote-updater[987]: Alpha legacy test mode disabled Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Retrieving Cloud Streaming UI Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Getting Tidal Cloud Configuration Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Getting Qobuz Cloud Configuration Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Asking plugin for UI Config Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Getting Spotify Cloud Configuration Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Asking plugin for UI Config Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Saving Spotify Acccount Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Got it Aug 31 19:18:05 ferrum-broen volumio[1357]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Got Tidal Cloud Configuration Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Got it Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:05 ferrum-broen volumio[1357]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 31 19:18:05 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 31 19:18:06 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:18:06 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Aug 31 19:18:06 ferrum-broen volumio[1357]: info: Loading i18n strings for locale pl Aug 31 19:18:06 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Aug 31 19:18:06 ferrum-broen volumio[1357]: info: Setting timezone to Europe/Warsaw Aug 31 19:18:06 ferrum-broen sudo[3316]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Aug 31 19:18:06 ferrum-broen sudo[3316]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:06 ferrum-broen sudo[3316]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:06 ferrum-broen sudo[3320]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Aug 31 19:18:06 ferrum-broen sudo[3320]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:06 ferrum-broen sudo[3320]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:06 ferrum-broen sudo[3324]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Aug 31 19:18:06 ferrum-broen sudo[3324]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:06 ferrum-broen sudo[3324]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:06 ferrum-broen sudo[3328]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Aug 31 19:18:06 ferrum-broen sudo[3328]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:06 ferrum-broen sudo[3328]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:06 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 31 19:18:06 ferrum-broen volumio[1357]: Updating browse sources language Aug 31 19:18:06 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:18:06 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Aug 31 19:18:06 ferrum-broen volumio[1357]: info: Loading i18n strings for locale pl Aug 31 19:18:06 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Aug 31 19:18:06 ferrum-broen volumio[1357]: info: Setting timezone to Europe/Warsaw Aug 31 19:18:06 ferrum-broen sudo[3333]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Aug 31 19:18:06 ferrum-broen sudo[3333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:06 ferrum-broen sudo[3333]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:06 ferrum-broen sudo[3337]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Aug 31 19:18:06 ferrum-broen sudo[3337]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:06 ferrum-broen sudo[3337]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:06 ferrum-broen sudo[3341]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Aug 31 19:18:06 ferrum-broen sudo[3341]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:06 ferrum-broen sudo[3341]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:06 ferrum-broen sudo[3345]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Aug 31 19:18:06 ferrum-broen sudo[3345]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:06 ferrum-broen sudo[3345]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:06 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:18:06 ferrum-broen volumio[1357]: info: Fetching Streaming Services browse cache Aug 31 19:18:07 ferrum-broen volumio[1357]: Updating browse sources language Aug 31 19:18:07 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:18:07 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 31 19:18:07 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Aug 31 19:18:07 ferrum-broen volumio[1357]: info: Loading i18n strings for locale pl Aug 31 19:18:07 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Aug 31 19:18:07 ferrum-broen volumio[1357]: info: Setting timezone to Europe/Warsaw Aug 31 19:18:07 ferrum-broen sudo[3349]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Aug 31 19:18:07 ferrum-broen sudo[3349]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:07 ferrum-broen sudo[3349]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:07 ferrum-broen sudo[3353]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Aug 31 19:18:07 ferrum-broen sudo[3353]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:07 ferrum-broen sudo[3353]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:07 ferrum-broen sudo[3357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Aug 31 19:18:07 ferrum-broen sudo[3357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:07 ferrum-broen sudo[3357]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:07 ferrum-broen sudo[3361]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Aug 31 19:18:07 ferrum-broen sudo[3361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:07 ferrum-broen sudo[3361]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:07 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Aug 31 19:18:07 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Aug 31 19:18:07 ferrum-broen sudo[3364]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 31 19:18:07 ferrum-broen sudo[3364]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:07 ferrum-broen volumio[1357]: Updating browse sources language Aug 31 19:18:07 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:18:07 ferrum-broen volumio[1357]: info: Fetching Streaming Services browse cache Aug 31 19:18:07 ferrum-broen volumio[1357]: info: Fetching Streaming Services browse cache Aug 31 19:18:09 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:18:10 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:10.786+02:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.0.56:47816 error="read tcp 192.168.0.50:7331->192.168.0.56:47816: read: connection reset by peer" Aug 31 19:18:10 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:10.786+02:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.0.56:47816 Aug 31 19:18:10 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:10.786+02:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.0.56:47816 Aug 31 19:18:10 ferrum-broen sudo[3364]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 31 19:18:10 ferrum-broen volumio[1357]: info: Preparing to save Alsa Options, stopping services first Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioPause Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreStateMachine::pause Aug 31 19:18:10 ferrum-broen volumio[1357]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"5","label":"AES/COAX/OPTO/I2S"},"disallowPush":true} Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 19:18:10 ferrum-broen volumio[1357]: info: Device 5 does not have any Mixer Control Available Aug 31 19:18:10 ferrum-broen volumio[1357]: info: QobuzConnect: setDeactiveState invoked Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:10 ferrum-broen vtcs[1958]: [2026-08-31 19:18:10.921] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Aug 31 19:18:10 ferrum-broen vtcs[1958]: [2026-08-31 19:18:10.923] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Aug 31 19:18:10 ferrum-broen sudo[3386]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 31 19:18:10 ferrum-broen sudo[3386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 31 19:18:10 ferrum-broen volumio[1357]: info: Updating Volume Controller Parameters: Device: 5 Name: AES/COAX/OPTO/I2S Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 31 19:18:10 ferrum-broen volumio[1357]: info: Disabling external Volume Control Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Aug 31 19:18:10 ferrum-broen sudo[3392]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 31 19:18:10 ferrum-broen sudo[3392]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:10 ferrum-broen systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreStateMachine::pushState Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioPushState Aug 31 19:18:10 ferrum-broen systemd[1]: vtcs.service: Deactivated successfully. Aug 31 19:18:10 ferrum-broen systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:10 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:10 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output update for this device Aug 31 19:18:10 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output Aug 31 19:18:10 ferrum-broen sudo[3395]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 31 19:18:10 ferrum-broen sudo[3395]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:10 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:10.958+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:10 ferrum-broen sudo[3395]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:10 ferrum-broen sudo[3386]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:10 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:10.959+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:10 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:10.959+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" id= title= Aug 31 19:18:10 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:10.959+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" id= title= Aug 31 19:18:10 ferrum-broen volumio[1357]: info: Preparing to generate the ALSA configuration file Aug 31 19:18:10 ferrum-broen sudo[3399]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 31 19:18:10 ferrum-broen sudo[3399]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:10 ferrum-broen volumio[1357]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 31 19:18:10 ferrum-broen volumio[1357]: info: Reading ALSA contributions from plugins. Aug 31 19:18:10 ferrum-broen volumio[1357]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Aug 31 19:18:10 ferrum-broen volumio[1357]: wlan0 Interface doesn't support scanning : Device or resource busy Aug 31 19:18:10 ferrum-broen volumio[1357]: info: Cannot use regular scanning, forcing with ap-force Aug 31 19:18:10 ferrum-broen sudo[3406]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 31 19:18:10 ferrum-broen sudo[3406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:10 ferrum-broen sudo[3410]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Aug 31 19:18:10 ferrum-broen sudo[3410]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:10 ferrum-broen sudo[3410]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:10 ferrum-broen volumio[1357]: command failed: Device or resource busy (-16) Aug 31 19:18:10 ferrum-broen volumio[1357]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Aug 31 19:18:10 ferrum-broen volumio[1357]: command failed: Device or resource busy (-16) Aug 31 19:18:10 ferrum-broen sudo[3399]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:11 ferrum-broen sudo[3406]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:11 ferrum-broen sudo[3415]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 31 19:18:11 ferrum-broen sudo[3415]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 19:18:11 ferrum-broen systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Aug 31 19:18:11 ferrum-broen qobuz-connect[1732]: 20260831 19:18:11.024 [1732.1732] INFO SampleApp: Stopping Local configuration server Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , getAdditionalUiSection Aug 31 19:18:11 ferrum-broen volumio[1357]: info: [HEM] Getting UI Config for section: audio Aug 31 19:18:11 ferrum-broen volumio[1357]: info: Asound.conf file unchanged, so no further update is needed Aug 31 19:18:11 ferrum-broen volumio[1357]: info: Output device has changed, restarting MPD Aug 31 19:18:11 ferrum-broen sudo[3422]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 19:18:11 ferrum-broen sudo[3422]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:11 ferrum-broen sudo[3422]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:11 ferrum-broen volumio[1357]: info: Output device has changed, restarting Shairport Sync Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 19:18:11 ferrum-broen sudo[3425]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 19:18:11 ferrum-broen sudo[3425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:11 ferrum-broen volumio[1357]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 19:18:11 ferrum-broen volumio[1357]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: QobuzConnect: setDeactiveState invoked Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen systemd[1]: Stopping mpd.service - Music Player Daemon... Aug 31 19:18:11 ferrum-broen sudo[3434]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 31 19:18:11 ferrum-broen sudo[3434]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:11 ferrum-broen sudo[3436]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 31 19:18:11 ferrum-broen sudo[3436]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:11 ferrum-broen volumio[1357]: info: MPD Permissions set Aug 31 19:18:11 ferrum-broen sudo[3444]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 31 19:18:11 ferrum-broen sudo[3444]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:11 ferrum-broen volumio[1357]: info: [HEM] Config value for i2s_predefined_mode: 0 Aug 31 19:18:11 ferrum-broen volumio[1357]: info: [HEM] Config value for i2s_format: standard Aug 31 19:18:11 ferrum-broen volumio[1357]: info: [HEM] Config value for i2s_pcm_slot_size: bits32 Aug 31 19:18:11 ferrum-broen volumio[1357]: info: [HEM] Config value for i2s_dsd_pin: p13 Aug 31 19:18:11 ferrum-broen volumio[1357]: info: [HEM] Config value for i2s_dsd_channel_assignment: leftOnWck Aug 31 19:18:11 ferrum-broen volumio[1357]: info: [HEM] Config value for i2s_wck_polarity: normal Aug 31 19:18:11 ferrum-broen volumio[1357]: info: [HEM] Config value for i2s_bck_polarity: normal Aug 31 19:18:11 ferrum-broen volumio[1357]: info: [HEM] Config value for i2s_sd_polarity: normal Aug 31 19:18:11 ferrum-broen volumio[1357]: info: [HEM] Config value for i2s_mclk_freq: undefined Aug 31 19:18:11 ferrum-broen volumio[1357]: info: [HEM] Config value for i2s_mapping: undefined Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen sudo[3444]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:11 ferrum-broen sudo[3436]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:11 ferrum-broen sudo[3434]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:11 ferrum-broen sudo[3451]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 31 19:18:11 ferrum-broen sudo[3451]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:11 ferrum-broen volumio[1357]: info: Starting Shairport Sync Aug 31 19:18:11 ferrum-broen sudo[3456]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 19:18:11 ferrum-broen sudo[3456]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:11 ferrum-broen systemd[1]: mpd.service: Deactivated successfully. Aug 31 19:18:11 ferrum-broen systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 31 19:18:11 ferrum-broen systemd[1]: mpd.socket: Deactivated successfully. Aug 31 19:18:11 ferrum-broen systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 31 19:18:11 ferrum-broen systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 31 19:18:11 ferrum-broen systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 31 19:18:11 ferrum-broen systemd[1]: Starting mpd.service - Music Player Daemon... Aug 31 19:18:11 ferrum-broen systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 31 19:18:11 ferrum-broen systemd[1]: shairport-sync.service: Deactivated successfully. Aug 31 19:18:11 ferrum-broen systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 31 19:18:11 ferrum-broen systemd[1]: shairport-sync.service: Consumed 1.678s CPU time. Aug 31 19:18:11 ferrum-broen systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 31 19:18:11 ferrum-broen sudo[3456]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:11 ferrum-broen volumio[1357]: info: Shairport-Sync Started Aug 31 19:18:11 ferrum-broen sudo[3459]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 19:18:11 ferrum-broen sudo[3459]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 31 19:18:11 ferrum-broen sudo[3459]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:11 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:11 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:11 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:11.361+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 31 19:18:11 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:11.363+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 19:18:11 ferrum-broen mpd[3476]: 2026-08-31T19:18:11 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 31 19:18:11 ferrum-broen systemd[1]: Started mpd.service - Music Player Daemon. Aug 31 19:18:11 ferrum-broen sudo[3425]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:11 ferrum-broen volumio[1357]: error: updateQueue error: null Aug 31 19:18:11 ferrum-broen qobuz-connect[1732]: 20260831 19:18:11.726 [1732.1732] INFO SampleApp: shat down connection on UNIX socket Aug 31 19:18:11 ferrum-broen volumio[1357]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Aug 31 19:18:11 ferrum-broen volumio[1357]: info: QobuzConnect: setDeactiveState invoked Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:11 ferrum-broen systemd[1]: qobuz-connect.service: Deactivated successfully. Aug 31 19:18:11 ferrum-broen systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Aug 31 19:18:11 ferrum-broen systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Aug 31 19:18:11 ferrum-broen sudo[3451]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:11 ferrum-broen sudo[3415]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:11 ferrum-broen volumio[1357]: info: Executing endpoint qc_getconfig Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Aug 31 19:18:11 ferrum-broen qobuz-connect[3479]: 20260831 19:18:11.762 [3479.3479] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Aug 31 19:18:11 ferrum-broen volumio[1357]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Aug 31 19:18:11 ferrum-broen volumio[1357]: info: QobuzConnect: QOBUZ Connect daemon connected Aug 31 19:18:11 ferrum-broen qobuz-connect[3479]: 20260831 19:18:11.764 [3479.3479] INFO VolumeManager: [0x10db158]: Setting new playback volume: 75 Aug 31 19:18:11 ferrum-broen qobuz-connect[3479]: 20260831 19:18:11.764 [3479.3479] INFO VolumeManager: [0x10db158]: Setting new mute state: 0 Aug 31 19:18:11 ferrum-broen qobuz-connect[3479]: 20260831 19:18:11.764 [3479.3479] INFO AudioStreamManager: [0x10daeb0]: Setting new audio download buffer size: 1048576 Aug 31 19:18:11 ferrum-broen qobuz-connect[3479]: 20260831 19:18:11.764 [3479.3479] INFO QobuzConnect: [0x10dba20]: Client initialized! Aug 31 19:18:11 ferrum-broen qobuz-connect[3479]: 20260831 19:18:11.764 [3479.3479] INFO SampleApp: Starting Avahi advertising, name: Ferrum Broen, service name: _qobuz-connect._tcp Aug 31 19:18:11 ferrum-broen qobuz-connect[3479]: 20260831 19:18:11.767 [3479.3479] INFO LocalConfigManager: [0x10dabd8]: Starting Local Configuration server Aug 31 19:18:11 ferrum-broen qobuz-connect[3479]: 20260831 19:18:11.767 [3479.3479] INFO SampleApp: Starting Local configuration server Aug 31 19:18:11 ferrum-broen qobuz-connect[3479]: 20260831 19:18:11.767 [3479.3479] INFO SampleApp: Connected to UNIX socket client 0x10c5908 Aug 31 19:18:11 ferrum-broen qobuz-connect[3479]: 20260831 19:18:11.912 [3479.3479] INFO SampleApp: Playback volume changed: 75 Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:11 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:12 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:12.253+02:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 31 19:18:13 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Aug 31 19:18:13 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 19:18:13 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 19:18:13 ferrum-broen volumio[1357]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 31 19:18:13 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 31 19:18:13 ferrum-broen volumio[1357]: info: Received Get System Version Aug 31 19:18:13 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 19:18:13 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:13 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:13 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:13 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:13 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:13 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:13 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:13 ferrum-broen volumio[1357]: info: TidalConnect service stoped! Aug 31 19:18:14 ferrum-broen volumio[1357]: info: TidalConnect service stoped! Aug 31 19:18:14 ferrum-broen volumio[1357]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 31 19:18:14 ferrum-broen volumio[1357]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 31 19:18:14 ferrum-broen sudo[3497]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 31 19:18:14 ferrum-broen sudo[3497]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:14 ferrum-broen systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Aug 31 19:18:14 ferrum-broen sudo[3497]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:14 ferrum-broen volumio[1357]: info: TidalConnect service stoped! Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 31 19:18:14 ferrum-broen volumio[1357]: info: Received Get System Version Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 19:18:14 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:14 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:14 ferrum-broen volumio[1357]: info: TidalConnect service stoped! Aug 31 19:18:14 ferrum-broen volumio[1357]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 31 19:18:14 ferrum-broen volumio[1357]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 31 19:18:14 ferrum-broen sudo[3511]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 31 19:18:14 ferrum-broen sudo[3511]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:14 ferrum-broen sudo[3511]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:14 ferrum-broen volumio[1357]: info: Executing endpoint tc_getconfig Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Aug 31 19:18:14 ferrum-broen vtcs[3500]: STARTING TidalConnect services, version: 1.6.1 Aug 31 19:18:14 ferrum-broen vtcs[3500]: STARTED TidalConnect services. Aug 31 19:18:14 ferrum-broen volumio[1357]: info: Executing endpoint tc_connect Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Aug 31 19:18:14 ferrum-broen volumio[1357]: info: Connecting to TidalConnect Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::servicePushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::pushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioPushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output update for this device Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Aug 31 19:18:14 ferrum-broen volumio[1357]: verbose: CURRENT POSITION 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::syncState stateService stop Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::syncState currentStatus stop Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::pushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioPushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output update for this device Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output Aug 31 19:18:14 ferrum-broen volumio[1357]: info: No code Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::pushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioPushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output update for this device Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::servicePushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::pushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioPushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output update for this device Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Aug 31 19:18:14 ferrum-broen volumio[1357]: verbose: CURRENT POSITION 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::syncState stateService stop Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::syncState currentStatus stop Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::pushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioPushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output update for this device Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output Aug 31 19:18:14 ferrum-broen volumio[1357]: info: No code Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::pushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioPushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output update for this device Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.170+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.170+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.171+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.171+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.171+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.171+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.171+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.171+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.172+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.173+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" id= title= Aug 31 19:18:14 ferrum-broen sudo[3392]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::getcurrentVolume Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreStateMachine::pushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioPushState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:14 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output update for this device Aug 31 19:18:14 ferrum-broen volumio[1357]: info: MRS: Pushing multiroomSync output Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.940+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.940+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.940+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" id= title= Aug 31 19:18:14 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:14.940+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" id= title= Aug 31 19:18:15 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:15.119+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 31 19:18:15 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:15.119+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 31 19:18:15 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:15 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:15 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:15 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:15 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:15 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:15 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:15 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 19:18:15 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 19:18:16 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:16.006+02:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 31 19:18:17 ferrum-broen volumio[1357]: info: TidalConnect service started! Aug 31 19:18:17 ferrum-broen volumio[1357]: info: TidalConnect service started! Aug 31 19:18:24 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 19:18:24 ferrum-broen volumio[1357]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 31 19:18:24 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 31 19:18:24 ferrum-broen volumio[1357]: info: Received Get System Version Aug 31 19:18:24 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 19:18:24 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:24 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:24 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:24 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:24 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:24 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:24 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:25 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 192.168.0.50 from 192.168.0.61 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Edg/152.0.0.0 Engine version: 3 Transport: polling Total Clients: 8 Aug 31 19:18:25 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 19:18:25 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:18:25 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:25 ferrum-broen volumio[1357]: info: Retrieving Cloud Streaming UI Aug 31 19:18:25 ferrum-broen volumio[1357]: info: Getting Tidal Cloud Configuration Aug 31 19:18:25 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:25 ferrum-broen volumio[1357]: info: Getting Qobuz Cloud Configuration Aug 31 19:18:25 ferrum-broen volumio[1357]: info: Asking plugin for UI Config Aug 31 19:18:25 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:25 ferrum-broen volumio[1357]: info: Getting Spotify Cloud Configuration Aug 31 19:18:25 ferrum-broen volumio[1357]: info: Asking plugin for UI Config Aug 31 19:18:25 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:25 ferrum-broen volumio[1357]: info: Saving Spotify Acccount Aug 31 19:18:25 ferrum-broen volumio[1357]: info: Got it Aug 31 19:18:25 ferrum-broen volumio[1357]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 31 19:18:25 ferrum-broen volumio[1357]: info: Got Tidal Cloud Configuration Aug 31 19:18:25 ferrum-broen volumio[1357]: info: Got it Aug 31 19:18:25 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 19:18:27 ferrum-broen volumio-remote-updater[987]: Test mode disabled Aug 31 19:18:27 ferrum-broen volumio-remote-updater[987]: Alpha mode enabled Aug 31 19:18:27 ferrum-broen volumio-remote-updater[987]: Alpha legacy test mode disabled Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 31 19:18:27 ferrum-broen volumio[1357]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Aug 31 19:18:27 ferrum-broen volumio[1357]: info: Loading i18n strings for locale en Aug 31 19:18:27 ferrum-broen volumio[1357]: Updating browse sources language Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Aug 31 19:18:27 ferrum-broen volumio[1357]: info: Setting timezone to Europe/Warsaw Aug 31 19:18:27 ferrum-broen sudo[3566]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Aug 31 19:18:27 ferrum-broen sudo[3566]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:27 ferrum-broen sudo[3566]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:27 ferrum-broen sudo[3570]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Aug 31 19:18:27 ferrum-broen sudo[3570]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:27 ferrum-broen sudo[3570]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:27 ferrum-broen sudo[3574]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Aug 31 19:18:27 ferrum-broen sudo[3574]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:27 ferrum-broen sudo[3574]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:27 ferrum-broen sudo[3578]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Aug 31 19:18:27 ferrum-broen sudo[3578]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:27 ferrum-broen sudo[3578]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Aug 31 19:18:27 ferrum-broen sudo[3581]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 31 19:18:27 ferrum-broen sudo[3581]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Aug 31 19:18:27 ferrum-broen volumio-remote-updater[987]: Test mode disabled Aug 31 19:18:27 ferrum-broen volumio-remote-updater[987]: Alpha mode enabled Aug 31 19:18:27 ferrum-broen volumio-remote-updater[987]: Alpha legacy test mode disabled Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 31 19:18:27 ferrum-broen volumio[1357]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 31 19:18:27 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 31 19:18:28 ferrum-broen volumio[1357]: info: Fetching Streaming Services browse cache Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CoreCommandRouter::Reload Ui Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Aug 31 19:18:29 ferrum-broen volumio[1357]: info: Wizard terminated Successfully Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumiosetStartupVolume Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 19:18:29 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:29.495+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" setupComplete=true Aug 31 19:18:29 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:29.495+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" setupComplete=true Aug 31 19:18:29 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:29 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 19:18:29 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 19:18:30 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 7 Aug 31 19:18:30 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:30.443+02:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 31 19:18:30 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 8 Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 31 19:18:31 ferrum-broen volumio[1357]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 31 19:18:31 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:31 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:31 ferrum-broen volumio[1357]: info: Listing playlists Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 31 19:18:31 ferrum-broen sudo[3581]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:31 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:31.813+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.0.56:42192 @ 0x24f62d0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 31 19:18:31 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:31.813+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.0.56:42192 @ 0x2122bd0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 31 19:18:31 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:31 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:31 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:31 ferrum-broen sudo[3629]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 19:18:31 ferrum-broen sudo[3631]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 19:18:31 ferrum-broen sudo[3631]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:31 ferrum-broen sudo[3629]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:31 ferrum-broen sudo[3629]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:31 ferrum-broen sudo[3631]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:31 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 192.168.0.50 from 192.168.0.61 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Edg/152.0.0.0 Engine version: 3 Transport: polling Total Clients: 8 Aug 31 19:18:32 ferrum-broen sudo[3635]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 19:18:32 ferrum-broen sudo[3635]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:32 ferrum-broen sudo[3637]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 19:18:32 ferrum-broen sudo[3637]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:32 ferrum-broen sudo[3635]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:32 ferrum-broen sudo[3637]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:32 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 192.168.0.50 from 192.168.0.61 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Edg/152.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 31 19:18:32 ferrum-broen volumio[1357]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 31 19:18:32 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:32 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:32 ferrum-broen volumio[1357]: info: Listing playlists Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:18:32 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:32 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:32 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 31 19:18:32 ferrum-broen volumio5-onboarding[1690]: time=2026-08-31T19:18:32.755+02:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 31 19:18:33 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:33 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:33 ferrum-broen sudo[3642]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 19:18:33 ferrum-broen sudo[3644]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 19:18:33 ferrum-broen sudo[3642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:33 ferrum-broen sudo[3644]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:33 ferrum-broen sudo[3642]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:33 ferrum-broen sudo[3644]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:33 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 192.168.0.50 from 192.168.0.56 UA: Mozilla/5.0 (Linux; Android 13; ASUS_I006D Build/TKQ1.220807.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Aug 31 19:18:33 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:18:33 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:33 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:33 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:33 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:33 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:33 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:33 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:33 ferrum-broen sudo[3649]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 19:18:33 ferrum-broen sudo[3649]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:33 ferrum-broen sudo[3649]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:33 ferrum-broen sudo[3651]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 19:18:33 ferrum-broen sudo[3651]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:33 ferrum-broen sudo[3651]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:33 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 31 19:18:34 ferrum-broen volumio[1357]: verbose: New Socket.io Connection to 192.168.0.50 from 192.168.0.56 UA: Mozilla/5.0 (Linux; Android 13; ASUS_I006D Build/TKQ1.220807.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:18:34 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:34 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 31 19:18:34 ferrum-broen volumio[1357]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 31 19:18:34 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:34 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:34 ferrum-broen volumio[1357]: info: Listing playlists Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:18:34 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:34 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:34 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:18:36 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:36 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 19:18:36 ferrum-broen volumio-remote-updater[987]: Test mode disabled Aug 31 19:18:36 ferrum-broen volumio-remote-updater[987]: Alpha mode enabled Aug 31 19:18:36 ferrum-broen volumio-remote-updater[987]: Alpha legacy test mode disabled Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 31 19:18:36 ferrum-broen volumio[1357]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Aug 31 19:18:36 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 19:18:37 ferrum-broen volumio-remote-updater[987]: Test mode disabled Aug 31 19:18:37 ferrum-broen volumio-remote-updater[987]: Alpha mode enabled Aug 31 19:18:37 ferrum-broen volumio-remote-updater[987]: Alpha legacy test mode disabled Aug 31 19:18:37 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 31 19:18:37 ferrum-broen volumio[1357]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 31 19:18:37 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 31 19:18:37 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Aug 31 19:18:37 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 19:18:37 ferrum-broen volumio-remote-updater[987]: Test mode disabled Aug 31 19:18:37 ferrum-broen volumio-remote-updater[987]: Alpha mode enabled Aug 31 19:18:37 ferrum-broen volumio-remote-updater[987]: Alpha legacy test mode disabled Aug 31 19:18:37 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 31 19:18:37 ferrum-broen volumio[1357]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 31 19:18:37 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 31 19:18:38 ferrum-broen volumio[1357]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 19:18:38 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 31 19:18:38 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 31 19:18:38 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 31 19:18:38 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Aug 31 19:18:38 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , getAdditionalUiSection Aug 31 19:18:38 ferrum-broen volumio[1357]: info: [HEM] Getting UI Config for section: system Aug 31 19:18:38 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Aug 31 19:18:38 ferrum-broen volumio[1357]: info: [HEM:NvmeManager] NVMe device not found or not accessible via lsblk: Command failed: lsblk -J -b -o NAME,SIZE,MODEL,LABEL,MOUNTPOINT,TYPE /dev/nvme0n1 Aug 31 19:18:38 ferrum-broen volumio[1357]: lsblk: /dev/nvme0n1: not a block device Aug 31 19:18:38 ferrum-broen volumio[1357]: info: Received Get System Version Aug 31 19:18:38 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 19:18:40 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 19:18:40 ferrum-broen volumio[1357]: info: Received Get System Info Aug 31 19:18:40 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 19:18:40 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 19:18:40 ferrum-broen volumio[1357]: info: Discovery: Getting this device information Aug 31 19:18:40 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:40 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:40 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 19:18:40 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 31 19:18:42 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 31 19:18:42 ferrum-broen volumio[1357]: info: Command Delete User Data Received Aug 31 19:18:42 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: inputs , setMCUFactoryReset Aug 31 19:18:42 ferrum-broen volumio[1357]: info: Signalling MCU to Factory Reset Aug 31 19:18:42 ferrum-broen volumio[1357]: info: MCU Signalled Factory reset: 1 Aug 31 19:18:42 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Aug 31 19:18:42 ferrum-broen volumio[1357]: info: [HEM] ACTLEDDIMM received: 30 Aug 31 19:18:42 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Aug 31 19:18:42 ferrum-broen volumio[1357]: info: [HEM] STBYLEDDIMM received: 10 Aug 31 19:18:42 ferrum-broen volumio[1357]: info: MCU Signalled Auto Boot Mode On Power Active Aug 31 19:18:42 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Aug 31 19:18:42 ferrum-broen volumio[1357]: info: [HEM] TRIGDIR received: INPUT Aug 31 19:18:42 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Aug 31 19:18:42 ferrum-broen volumio[1357]: info: [HEM] TRIGINACTION received: 0 Aug 31 19:18:42 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , deleteUserData Aug 31 19:18:42 ferrum-broen volumio[1357]: info: Created User Data delete file, rebooting Aug 31 19:18:42 ferrum-broen volumio[1357]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Aug 31 19:18:42 ferrum-broen volumio[1357]: info: PLUGIN onReboot : networkfs Aug 31 19:18:42 ferrum-broen sudo[3686]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reboot Aug 31 19:18:42 ferrum-broen sudo[3686]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 31 19:18:42 ferrum-broen systemd-logind[976]: The system will reboot now! Aug 31 19:18:42 ferrum-broen systemd-logind[976]: System is rebooting. Aug 31 19:18:42 ferrum-broen sudo[3686]: pam_unix(sudo:session): session closed for user root Aug 31 19:18:42 ferrum-broen volumio[1357]: info: Rebooting Aug 31 19:18:42 ferrum-broen systemd[1]: Removed slice system-modprobe.slice - Slice /system/modprobe. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped target bluetooth.target - Bluetooth Support. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped target graphical.target - Graphical Interface. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped target rpc_pipefs.target. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped target rpcbind.target - RPC Port Mapper. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped target timers.target - Timer Units. Aug 31 19:18:42 ferrum-broen systemd[1]: apt-daily-upgrade.timer: Deactivated successfully. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped apt-daily-upgrade.timer - Daily apt upgrade and clean activities. Aug 31 19:18:42 ferrum-broen systemd[1]: apt-daily.timer: Deactivated successfully. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped apt-daily.timer - Daily apt download activities. Aug 31 19:18:42 ferrum-broen systemd[1]: dpkg-db-backup.timer: Deactivated successfully. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped dpkg-db-backup.timer - Daily dpkg database backup timer. Aug 31 19:18:42 ferrum-broen systemd[1]: e2scrub_all.timer: Deactivated successfully. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems. Aug 31 19:18:42 ferrum-broen systemd[1]: fstrim.timer: Deactivated successfully. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped fstrim.timer - Discard unused blocks once a week. Aug 31 19:18:42 ferrum-broen systemd[1]: ntpsec-rotate-stats.timer: Deactivated successfully. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped ntpsec-rotate-stats.timer - Rotate ntpd stats daily. Aug 31 19:18:42 ferrum-broen systemd[1]: setdatetime-helper.timer: Deactivated successfully. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped setdatetime-helper.timer - Volumio Time Sync Watchdog Timer. Aug 31 19:18:42 ferrum-broen systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 31 19:18:42 ferrum-broen systemd[1]: Stopped target usb-gadget.target - Hardware activated USB gadget. Aug 31 19:18:42 ferrum-broen systemd[1]: systemd-rfkill.socket: Deactivated successfully. Aug 31 19:18:42 ferrum-broen systemd[1]: Closed systemd-rfkill.socket - Load/Save RF Kill Switch Status /dev/rfkill Watch. Aug 31 19:18:43 ferrum-broen volumio[1357]: info: [fsct] ipc connection closed Aug 31 19:18:43 ferrum-broen systemd[1]: Unmounting run-rpc_pipefs.mount - RPC Pipe File System... Aug 31 19:18:43 ferrum-broen fsctd[1760]: [2026-08-31T17:18:43Z INFO fsct_driver::orchestrator] Orchestrator shutdown requested Aug 31 19:18:43 ferrum-broen fsctd[1760]: [2026-08-31T17:18:43Z INFO fsct_driver::ipc] IPC connection stop requested, id = 47b97063-33ae-4ed7-92e9-2ae254477a5e Aug 31 19:18:43 ferrum-broen fsctd[1760]: [2026-08-31T17:18:43Z INFO fsct_driver::player_manager] Player 1 unregistered Aug 31 19:18:43 ferrum-broen fsctd[1760]: [2026-08-31T17:18:43Z INFO fsct_driver::ipc] IPC connection closed, id = 47b97063-33ae-4ed7-92e9-2ae254477a5e Aug 31 19:18:43 ferrum-broen fsctd[1760]: [2026-08-31T17:18:43Z INFO fsct_driver::ipc] IPC server stopped Aug 31 19:18:43 ferrum-broen systemd[1]: Stopping bluealsa.service - BlueALSA service... Aug 31 19:18:43 ferrum-broen systemd[1]: Stopping fsct-driver.service - FSCT driver... Aug 31 19:18:43 ferrum-broen systemd[1]: Stopping mpd.service - Music Player Daemon... Aug 31 19:18:43 ferrum-broen systemd[1]: Starting plymouth-reboot.service - Show Plymouth Reboot Screen... Aug 31 19:18:43 ferrum-broen qobuz-connect[3479]: 20260831 19:18:43.012 [3479.3479] INFO SampleApp: Stopping Local configuration server Aug 31 19:18:43 ferrum-broen bluealsa[1079]: ../src/ba-adapter.c:144: Freeing adapter: hci0 Aug 31 19:18:43 ferrum-broen bluetoothd[952]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/1 Aug 31 19:18:43 ferrum-broen systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Aug 31 19:18:43 ferrum-broen systemd[1]: rpi-display-backlight.service - Turns off Raspberry Pi display backlight on shutdown/reboot was skipped because of an unmet condition check (ConditionPathIsDirectory=/proc/device-tree/rpi_backlight). Aug 31 19:18:43 ferrum-broen systemd[1]: Stopping systemd-random-seed.service - Load/Save Random Seed... Aug 31 19:18:43 ferrum-broen systemd[1]: Stopping systemd-timedated.service - Time & Date Service... Aug 31 19:18:43 ferrum-broen systemd[1]: Stopping volumio5-onboarding.service - Volumio5 Onboarding Server... Aug 31 19:18:43 ferrum-broen systemd[1]: Stopping volumiobt.service - Volumio Bluetooth Module... Aug 31 19:18:43 ferrum-broen systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Aug 31 19:18:43 ferrum-broen bluetoothd[952]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/2 Aug 31 19:18:43 ferrum-broen systemd[1]: bluealsa.service: Deactivated successfully. Aug 31 19:18:43 ferrum-broen systemd[1]: Stopped bluealsa.service - BlueALSA service. Aug 31 19:18:43 ferrum-broen systemd[1]: volumio5-onboarding.service: Deactivated successfully. Aug 31 19:18:43 ferrum-broen systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Aug 31 19:18:43 ferrum-broen bluetoothd[952]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/2 Aug 31 19:18:43 ferrum-broen bluetoothd[952]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/1 Aug 31 19:18:43 ferrum-broen volumiobt[3696]: INFO [BTSTART] Disconnecting all Bluetooth devices... Aug 31 19:18:43 ferrum-broen systemd[1]: fsct-driver.service: Deactivated successfully. Aug 31 19:18:43 ferrum-broen systemd[1]: Stopped fsct-driver.service - FSCT driver. Aug 31 19:18:43 ferrum-broen systemd[1]: systemd-timedated.service: Deactivated successfully. Aug 31 19:18:43 ferrum-broen systemd[1]: Stopped systemd-timedated.service - Time & Date Service. Aug 31 19:18:43 ferrum-broen systemd[1]: mpd.service: Deactivated successfully. Aug 31 19:18:43 ferrum-broen systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 31 19:18:43 ferrum-broen systemd[1]: vtcs.service: Deactivated successfully. Aug 31 19:18:43 ferrum-broen systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Aug 31 19:18:43 ferrum-broen systemd[1]: run-rpc_pipefs.mount: Deactivated successfully. Aug 31 19:18:43 ferrum-broen systemd[1]: Unmounted run-rpc_pipefs.mount - RPC Pipe File System. Aug 31 19:18:43 ferrum-broen systemd[1]: Received SIGRTMIN+20 from PID 3692 (plymouthd). Aug 31 19:18:43 ferrum-broen systemd[1]: systemd-random-seed.service: Deactivated successfully. Aug 31 19:18:43 ferrum-broen systemd[1]: Stopped systemd-random-seed.service - Load/Save Random Seed. Aug 31 19:18:43 ferrum-broen systemd[1]: Started plymouth-reboot.service - Show Plymouth Reboot Screen. Aug 31 19:18:43 ferrum-broen systemd[1]: plymouth-switch-root-initramfs.service - Tell Plymouth To Jump To initramfs was skipped because of an unmet condition check (ConditionPathExists=/run/initramfs/bin/sh). Aug 31 19:18:43 ferrum-broen bluetoothd[952]: Path / reserved for Adv Monitor app :1.45 Aug 31 19:18:43 ferrum-broen bluetoothd[952]: Adv Monitor app :1.45 disconnected from D-Bus Aug 31 19:18:43 ferrum-broen volumiobt[3708]: Attempting to disconnect from 64:42:F7:72:78:AC Aug 31 19:18:43 ferrum-broen volumiobt[3708]: [NEW] Media /org/bluez/hci0 Aug 31 19:18:43 ferrum-broen volumiobt[3708]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Aug 31 19:18:43 ferrum-broen volumiobt[3708]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Aug 31 19:18:43 ferrum-broen volumiobt[3708]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Aug 31 19:18:43 ferrum-broen bluetoothd[952]: Path / reserved for Adv Monitor app :1.46 Aug 31 19:18:43 ferrum-broen volumiobt[3708]: AdvertisementMonitor path registered Aug 31 19:18:43 ferrum-broen qobuz-connect[3479]: 20260831 19:18:43.807 [3479.3479] INFO SampleApp: shat down connection on UNIX socket Aug 31 19:18:43 ferrum-broen volumio[1357]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Aug 31 19:18:43 ferrum-broen volumio[1357]: info: QobuzConnect: setDeactiveState invoked Aug 31 19:18:43 ferrum-broen volumio[1357]: info: CoreCommandRouter::volumioGetState Aug 31 19:18:43 ferrum-broen volumio[1357]: info: CorePlayQueue::getTrack 0 Aug 31 19:18:43 ferrum-broen systemd[1]: qobuz-connect.service: Deactivated successfully. Aug 31 19:18:43 ferrum-broen systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Aug 31 19:18:44 ferrum-broen volumio[1357]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 31 19:18:45 ferrum-broen volumio[1357]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 19:18:45 ferrum-broen volumio[1357]: Error: write EPIPE Aug 31 19:18:45 ferrum-broen volumio[1357]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) Aug 31 19:18:45 ferrum-broen volumio[1357]: at writeGeneric (node:internal/stream_base_commons:151:3) Aug 31 19:18:45 ferrum-broen volumio[1357]: at Socket._writeGeneric (node:net:952:11) Aug 31 19:18:45 ferrum-broen volumio[1357]: at Socket._write (node:net:964:8) Aug 31 19:18:45 ferrum-broen volumio[1357]: at writeOrBuffer (node:internal/streams/writable:399:12) Aug 31 19:18:45 ferrum-broen volumio[1357]: at _write (node:internal/streams/writable:340:10) Aug 31 19:18:45 ferrum-broen volumio[1357]: at Writable.write (node:internal/streams/writable:344:10) Aug 31 19:18:45 ferrum-broen volumio[1357]: at /volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:102:19 Aug 31 19:18:45 ferrum-broen volumio[1357]: at new Promise () Aug 31 19:18:45 ferrum-broen volumio[1357]: at Mux.call (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:87:12) Aug 31 19:18:45 ferrum-broen volumio[1357]: at _FsctIpcClient.performHandshake (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:325:28) Aug 31 19:18:45 ferrum-broen volumio[1357]: at _FsctIpcClient.connectToEndpoint (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:316:48) Aug 31 19:18:45 ferrum-broen volumio[1357]: at async connectAndRegister (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/ferrum_streaming_control_technology_real:1:1890) { Aug 31 19:18:45 ferrum-broen volumio[1357]: errno: -32, Aug 31 19:18:45 ferrum-broen volumio[1357]: code: 'EPIPE', Aug 31 19:18:45 ferrum-broen volumio[1357]: syscall: 'write' Aug 31 19:18:45 ferrum-broen volumio[1357]: } Aug 31 19:18:45 ferrum-broen volumio[1357]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 19:18:45 ferrum-broen sudo[3724]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-31 19:17' Aug 31 19:18:45 ferrum-broen sudo[3724]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="ebd772339e193fb4b3a98c68e63a0009e72d6f27" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="9938d7179e3b7c4e41f3e2d60c255985cff08fee" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="ferrumbroen" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Aug 31 16:06:16 UTC 2026" VOLUMIO_VERSION="4.205" VOLUMIO_HARDWARE="cm5" VOLUMIO_DEVICENAME="CM5" VOLUMIO_HASH="0fbb06c57b14ba8aa1f09ec077bc0bfc"