Aug 28 18:45:16 volumiopi systemd[1]: Stopping upower.service - Daemon for power management... Aug 28 18:45:16 volumiopi systemd[1]: upower.service: Deactivated successfully. Aug 28 18:45:16 volumiopi systemd[1]: Stopped upower.service - Daemon for power management. Aug 28 18:45:16 volumiopi dbus-daemon[623]: [system] Reloaded configuration Aug 28 18:45:16 volumiopi shairport-sync[1679]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio5-onboarding[1760]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi dbus-daemon[623]: [system] Reloaded configuration Aug 28 18:45:16 volumiopi shairport-sync[1679]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio5-onboarding[1760]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:45:16 volumiopi systemd[1]: Reloading. Aug 28 18:45:19 volumiopi systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 18:45:19 volumiopi systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 18:45:27 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 28 18:45:27 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.331+09:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=228.655606ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.358+09:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s Aug 28 18:45:27 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 18:45:27 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 18:45:27 volumiopi volumio[1102]: info: Discovery: Getting this device information Aug 28 18:45:27 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:27 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:27 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.386+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=27.304874ms Aug 28 18:45:27 volumiopi volumio[1102]: verbose: New Socket.io Connection to 192.168.219.166:3000 from 192.168.219.150 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Aug 28 18:45:27 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 28 18:45:27 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.484+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=125.634084ms Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.484+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=125.532157ms Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.515+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=https://www.googleapis.com duration=154.030145ms Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.536+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=https://google.com duration=175.803726ms Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.557+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=197.953504ms Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.593+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=http://pushupdates.volumio.org duration=233.669804ms Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.593+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=https://securetoken.googleapis.com duration=234.569854ms Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.606+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=https://functions.volumio.cloud duration=246.072372ms Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.613+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=https://functions.volumio.cloud duration=253.258914ms Aug 28 18:45:27 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:27.852+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=https://database.volumio.cloud duration=491.160135ms Aug 28 18:45:28 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:28.025+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=http://cddb.volumio.org duration=665.403339ms Aug 28 18:45:28 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:28.067+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=204.083266ms timeout=10s endpoint=http://plugins.volumio.org duration=706.701255ms Aug 28 18:45:28 volumiopi sudo[3037]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 28 18:45:28 volumiopi sudo[3035]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 28 18:45:28 volumiopi sudo[3035]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:28 volumiopi sudo[3037]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:28 volumiopi sudo[3037]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:28 volumiopi sudo[3035]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:28 volumiopi volumio[1102]: verbose: New Socket.io Connection to 192.168.219.166 from 192.168.219.150 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Aug 28 18:45:28 volumiopi sudo[3043]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 28 18:45:28 volumiopi sudo[3043]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:28 volumiopi sudo[3045]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 28 18:45:28 volumiopi sudo[3045]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:28 volumiopi sudo[3045]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:28 volumiopi sudo[3043]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:28 volumiopi volumio[1102]: verbose: New Socket.io Connection to 192.168.219.166 from 192.168.219.150 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetVisibleSources Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:28 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 28 18:45:28 volumiopi volumio[1102]: info: Received Get System Info Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 18:45:28 volumiopi volumio[1102]: info: Discovery: Getting this device information Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:28 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:28 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:28 volumiopi volumio[1102]: info: Listing playlists Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 28 18:45:28 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 28 18:45:30 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 28 18:45:30 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 18:45:30 volumiopi volumio[1102]: info: Received Get System Info Aug 28 18:45:30 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 18:45:30 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 18:45:30 volumiopi volumio[1102]: info: Discovery: Getting this device information Aug 28 18:45:30 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:30 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:30 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 18:45:30 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.334+09:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=222.462127ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.399+09:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.431+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=31.490116ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.537+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=137.000343ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.537+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=137.14805ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.553+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=https://www.googleapis.com duration=152.344153ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.580+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=https://google.com duration=179.879085ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.589+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=188.440751ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.631+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=http://pushupdates.volumio.org duration=230.846424ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.637+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=https://securetoken.googleapis.com duration=237.474194ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.643+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=https://functions.volumio.cloud duration=242.004114ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.663+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=https://database.volumio.cloud duration=262.406122ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.793+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=https://functions.volumio.cloud duration=391.902866ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.802+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=http://cddb.volumio.org duration=401.700774ms Aug 28 18:45:31 volumiopi volumio5-onboarding[1760]: time=2026-08-28T18:45:31.808+09:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.219.150:60562,00:00:00:00:00:00%01 @ 0x2f954d0" latency=227.845001ms timeout=10s endpoint=http://plugins.volumio.org duration=407.763236ms Aug 28 18:45:31 volumiopi sudo[3055]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 28 18:45:31 volumiopi sudo[3055]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:31 volumiopi sudo[3057]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 28 18:45:31 volumiopi sudo[3057]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:31 volumiopi sudo[3057]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:31 volumiopi sudo[3055]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:32 volumiopi volumio[1102]: verbose: New Socket.io Connection to 192.168.219.166 from 192.168.219.150 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Aug 28 18:45:32 volumiopi sudo[3064]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 28 18:45:32 volumiopi sudo[3064]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:32 volumiopi sudo[3066]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 28 18:45:32 volumiopi sudo[3066]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:32 volumiopi sudo[3066]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:32 volumiopi sudo[3064]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:32 volumiopi volumio[1102]: verbose: New Socket.io Connection to 192.168.219.166 from 192.168.219.150 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 18:45:32 volumiopi volumio[1102]: info: Received Get System Info Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 18:45:32 volumiopi volumio[1102]: info: Discovery: Getting this device information Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:32 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetVisibleSources Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:32 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 28 18:45:32 volumiopi volumio[1102]: info: Received Get System Info Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 18:45:32 volumiopi volumio[1102]: info: Discovery: Getting this device information Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:32 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:32 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:32 volumiopi volumio[1102]: info: Listing playlists Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 28 18:45:32 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 28 18:45:34 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 28 18:45:34 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 18:45:34 volumiopi volumio[1102]: info: Received Get System Info Aug 28 18:45:34 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 18:45:34 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 18:45:34 volumiopi volumio[1102]: info: Discovery: Getting this device information Aug 28 18:45:34 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:34 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:34 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 18:45:35 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 18:45:35 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 28 18:45:35 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 18:45:35 volumiopi volumio[1102]: info: Received Get System Info Aug 28 18:45:35 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 18:45:35 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 18:45:35 volumiopi volumio[1102]: info: Discovery: Getting this device information Aug 28 18:45:35 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:35 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:35 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 18:45:38 volumiopi volumio[1102]: info: Enabling plugin touch_display Aug 28 18:45:38 volumiopi volumio[1102]: info: Loading plugin "touch_display"... Aug 28 18:45:39 volumiopi volumio[1102]: info: PLUGIN START: touch_display Aug 28 18:45:39 volumiopi volumio[1102]: info: Loading i18n strings for locale ko Aug 28 18:45:39 volumiopi volumio[1102]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 28 18:45:39 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 18:45:39 volumiopi volumio[1102]: info: touch_display: No backlight interface detected. Aug 28 18:45:39 volumiopi sudo[3186]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Aug 28 18:45:39 volumiopi sudo[3186]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:39 volumiopi sudo[3188]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Aug 28 18:45:39 volumiopi sudo[3188]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:39 volumiopi volumio[1102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Aug 28 18:45:39 volumiopi sudo[3190]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Aug 28 18:45:39 volumiopi sudo[3190]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:39 volumiopi volumio[1102]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Aug 28 18:45:39 volumiopi sudo[3195]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Aug 28 18:45:39 volumiopi sudo[3195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:39 volumiopi sudo[3195]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:39 volumiopi volumio[1102]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Aug 28 18:45:40 volumiopi systemd[1]: Reloading. Aug 28 18:45:40 volumiopi volumio[1102]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 18:45:42 volumiopi systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 18:45:42 volumiopi systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 18:45:42 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 28 18:45:43 volumiopi systemd[1]: Reloading. Aug 28 18:45:43 volumiopi sudo[3188]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:43 volumiopi volumio[1102]: info: touch_display: systemctl disable getty@tty1.service succeeded. Aug 28 18:45:45 volumiopi systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 18:45:45 volumiopi systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 18:45:45 volumiopi sudo[3190]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:45 volumiopi volumio[1102]: info: touch_display: systemctl daemon-reload succeeded. Aug 28 18:45:45 volumiopi systemd[1]: Stopping getty@tty1.service - Getty on tty1... Aug 28 18:45:45 volumiopi systemd[1]: getty@tty1.service: Deactivated successfully. Aug 28 18:45:45 volumiopi systemd[1]: Stopped getty@tty1.service - Getty on tty1. Aug 28 18:45:45 volumiopi sudo[3248]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Aug 28 18:45:45 volumiopi sudo[3248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:45:45 volumiopi sudo[3186]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:45 volumiopi volumio[1102]: info: touch_display: systemctl stop getty@tty1.service succeeded. Aug 28 18:45:46 volumiopi sudo[3248]: pam_unix(sudo:session): session closed for user root Aug 28 18:45:46 volumiopi volumio[1102]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service Aug 28 18:45:46 volumiopi volumio[1102]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found. Aug 28 18:45:46 volumiopi volumio[1102]: info: Error: Error Aug 28 18:45:52 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 28 18:45:52 volumiopi volumio[1102]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 28 18:45:52 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 28 18:45:52 volumiopi volumio[1102]: info: Received Get System Version Aug 28 18:45:52 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 18:45:52 volumiopi volumio[1102]: info: Received Get System Info Aug 28 18:45:52 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 18:45:52 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 18:45:52 volumiopi volumio[1102]: info: Discovery: Getting this device information Aug 28 18:45:52 volumiopi volumio[1102]: info: CoreCommandRouter::volumioGetState Aug 28 18:45:52 volumiopi volumio[1102]: info: CorePlayQueue::getTrack 0 Aug 28 18:45:52 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 18:45:58 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 18:45:58 volumiopi volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 28 18:46:02 volumiopi dbus-daemon[623]: [system] Reloaded configuration Aug 28 18:46:02 volumiopi volumio5-onboarding[1760]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:46:02 volumiopi shairport-sync[1679]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:46:02 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:46:02 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:46:02 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:46:02 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:46:02 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:46:02 volumiopi volumio[1102]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Aug 28 18:46:02 volumiopi sudo[3290]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Aug 28 18:46:02 volumiopi sudo[3290]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:46:02 volumiopi sudo[3292]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Aug 28 18:46:02 volumiopi sudo[3292]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:46:02 volumiopi sudo[3290]: pam_unix(sudo:session): session closed for user root Aug 28 18:46:02 volumiopi volumio[1102]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Aug 28 18:46:02 volumiopi volumio[1102]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 18:46:02 volumiopi sudo[3297]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Aug 28 18:46:02 volumiopi sudo[3297]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:46:02 volumiopi sudo[3294]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Aug 28 18:46:02 volumiopi sudo[3294]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 18:46:02 volumiopi volumio[1102]: TypeError: Cannot read properties of undefined (reading 'split') Aug 28 18:46:02 volumiopi volumio[1102]: at /data/plugins/user_interface/touch_display/index.js:1255:37 Aug 28 18:46:02 volumiopi volumio[1102]: at ChildProcess.exithandler (node:child_process:413:7) Aug 28 18:46:02 volumiopi volumio[1102]: at ChildProcess.emit (node:events:514:28) Aug 28 18:46:02 volumiopi volumio[1102]: at maybeClose (node:internal/child_process:1105:16) Aug 28 18:46:02 volumiopi volumio[1102]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) Aug 28 18:46:02 volumiopi volumio[1102]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 18:46:02 volumiopi sudo[3297]: pam_unix(sudo:session): session closed for user root Aug 28 18:46:02 volumiopi systemd[1]: Reloading. Aug 28 18:46:04 volumiopi sudo[3346]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-28 18:45' Aug 28 18:46:04 volumiopi sudo[3346]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"