Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.204+01:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.13.107:52705 @ 0x24c9bc0" latency=38.465485ms timeout=10s Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.204+01:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.205+01:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.13.107:52705 @ 0x24c9bc0" latency=41.376084ms platform=PLATFORM_IOS version=5.260120.0 Feb 21 18:17:02 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:02 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:02 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.213+01:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" name="Alfred Player" Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.216+01:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" language=en Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.243+01:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" timezone=Europe/Vienna Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.245+01:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" available=true connected=true macAddress=dc:a6:32:5c:52:4a ip4Address=192.168.13.106/24 ip6Address= Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.248+01:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.249+01:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" setupComplete=true Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 18:17:02 alfred-player volumio[1250]: amixer -c 0 info | grep "bcm2835 ALSA" Feb 21 18:17:02 alfred-player volumio[1250]: amixer -c 1 info | grep "bcm2835 Headphones" Feb 21 18:17:02 alfred-player volumio[1250]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' Feb 21 18:17:02 alfred-player volumio[1250]: amixer -c 2 info | grep "vc4-hdmi-0" Feb 21 18:17:02 alfred-player volumio[1250]: Card sysdefault:2 'vc4hdmi0'/'vc4-hdmi-0' Feb 21 18:17:02 alfred-player volumio[1250]: amixer -c 3 info | grep "vc4-hdmi-1" Feb 21 18:17:02 alfred-player volumio[1250]: Card sysdefault:3 'vc4hdmi1'/'vc4-hdmi-1' Feb 21 18:17:02 alfred-player volumio[1250]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4 Feb 21 18:17:02 alfred-player volumio[1250]: /bin/sh: 1: /usr/local/bin/alsacap: not found Feb 21 18:17:02 alfred-player volumio[1250]: {"cmd":"/usr/local/bin/alsacap -C 4","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 4\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Feb 21 18:17:02 alfred-player volumio[1250]: amixer -c 4 info | grep "HiFiBerry Digi" Feb 21 18:17:02 alfred-player volumio[1250]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4 Feb 21 18:17:02 alfred-player volumio[1250]: /bin/sh: 1: /usr/local/bin/alsacap: not found Feb 21 18:17:02 alfred-player volumio[1250]: {"cmd":"/usr/local/bin/alsacap -C 4","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 4\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Feb 21 18:17:02 alfred-player volumio[1250]: amixer -c 4 info | grep "snd_rpi_hifiberry_digi" Feb 21 18:17:02 alfred-player volumio[1250]: Card sysdefault:4 'sndrpihifiberry'/'snd_rpi_hifiberry_digi' Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.928+01:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" selectedOutputId=4 Feb 21 18:17:02 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:02 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:02 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.975+01:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" currentVersion=4.096 latestVersion=4.096 Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.975+01:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" status=UPDATE_STATUS_NONE progress=0 Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.976+01:00 level=INFO msg="emitting user changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" userId= Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.976+01:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" providers=3 Feb 21 18:17:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:17:02 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:02.990+01:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" plugins=0 Feb 21 18:17:03 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:03 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:03 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:03.024+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 21 18:17:03 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:03.024+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.13.107:52705 @ 0x24c9bc0" id=tidal://song/448913413 title="Hooker Thing" Feb 21 18:17:03 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:03.074+01:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.13.107:52705 @ 0x24c9bc0" latency=47.652646ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Feb 21 18:17:03 alfred-player volumio[1250]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 21 18:17:03 alfred-player sudo[1686]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 18:17:03 alfred-player sudo[1686]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:03 alfred-player sudo[1684]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 18:17:03 alfred-player sudo[1686]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:03 alfred-player sudo[1684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:03 alfred-player sudo[1684]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:03 alfred-player volumio[1250]: verbose: New Socket.io Connection to 192.168.13.106 from 192.168.13.107 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 Feb 21 18:17:04 alfred-player sudo[1690]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 18:17:04 alfred-player sudo[1690]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:04 alfred-player sudo[1692]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 18:17:04 alfred-player sudo[1690]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:04 alfred-player sudo[1692]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:04 alfred-player sudo[1692]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:04 alfred-player volumio[1250]: verbose: New Socket.io Connection to 192.168.13.106 from 192.168.13.107 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 Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetVisibleSources Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:04 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 21 18:17:04 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:04 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:04 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:04 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:04 alfred-player volumio[1250]: info: Listing playlists Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 21 18:17:04 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 21 18:17:06 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:17:06 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:06 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:06 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:06 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:06 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:06 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:06 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:06 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 21 18:17:06 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Feb 21 18:17:07 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:17:07 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:07 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:07 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:07 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:07 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:07 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:07 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:08 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Feb 21 18:17:08 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:17:11 alfred-player sudo[1700]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 18:17:11 alfred-player sudo[1700]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:11 alfred-player sudo[1700]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:11 alfred-player sudo[1701]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 18:17:11 alfred-player sudo[1701]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:11 alfred-player sudo[1701]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:11 alfred-player volumio[1250]: verbose: New Socket.io Connection to 192.168.13.106 from 192.168.13.107 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 Feb 21 18:17:11 alfred-player sudo[1705]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 18:17:11 alfred-player sudo[1705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:11 alfred-player sudo[1707]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 18:17:11 alfred-player sudo[1705]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:11 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:11 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:11 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:11 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetVisibleSources Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:11 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 21 18:17:11 alfred-player sudo[1707]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:11 alfred-player sudo[1707]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:11 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:11 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:11 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:11 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:11 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:11 alfred-player volumio[1250]: info: Listing playlists Feb 21 18:17:12 alfred-player volumio[1250]: verbose: New Socket.io Connection to 192.168.13.106 from 192.168.13.107 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 Feb 21 18:17:12 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:12 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:12 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:12 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetVisibleSources Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:12 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 21 18:17:12 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:12 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:12 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:12 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:12 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:12 alfred-player volumio[1250]: info: Listing playlists Feb 21 18:17:12 alfred-player systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Feb 21 18:17:12 alfred-player sudo[1729]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 18:17:12 alfred-player sudo[1729]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:12 alfred-player sudo[1729]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:13 alfred-player sudo[1728]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 18:17:13 alfred-player sudo[1728]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:13 alfred-player sudo[1728]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:13 alfred-player volumio[1250]: verbose: New Socket.io Connection to 192.168.13.106 from 192.168.13.107 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 Feb 21 18:17:13 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:13 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:13 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:13 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetVisibleSources Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:13 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 21 18:17:13 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:13 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:13 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:13 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:13 alfred-player volumio[1250]: info: Listing playlists Feb 21 18:17:13 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:13 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:13 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:13 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:13 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:13 alfred-player systemd[1]: setdatetime-helper.service: Deactivated successfully. Feb 21 18:17:13 alfred-player systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Feb 21 18:17:13 alfred-player systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Feb 21 18:17:13 alfred-player systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 21 18:17:13 alfred-player systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 21 18:17:14 alfred-player upmpdcli[1755]: Could not open config: /tmp/upmpdcli.conf Feb 21 18:17:14 alfred-player systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 21 18:17:14 alfred-player systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 21 18:17:14 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:17:14 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:14 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:14 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:14 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:14 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:14 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:14 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:14 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 21 18:17:14 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Feb 21 18:17:17 alfred-player volumio[1250]: error: MyVolumio Plugin failed to start in a timely fashion Feb 21 18:17:17 alfred-player volumio[1250]: [Metrics] CommandRouter: 37s 418.83ms Feb 21 18:17:17 alfred-player volumio[1250]: info: CoreCommandRouter::volumiosetStartupVolume Feb 21 18:17:17 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:17 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:17 alfred-player volumio[1250]: info: CoreCommandRouter::Close All Modals sent Feb 21 18:17:17 alfred-player volumio[1250]: info: CoreCommandRouter::Close All Modals sent Feb 21 18:17:18 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 21 18:17:18 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 18:17:18 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 21 18:17:19 alfred-player volumio[1250]: info: Discovery: adding 23974f25-6875-4c2f-99d9-877d37c04f0e Feb 21 18:17:19 alfred-player volumio[1250]: info: Discovery: Found device Alfred Player Feb 21 18:17:19 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:19 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:19 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:19 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 21 18:17:19 alfred-player volumio[1250]: info: Adding plugin bluetooth to MyMusic Plugins Feb 21 18:17:19 alfred-player volumio[1250]: info: Adding plugin multiroom to MyMusic Plugins Feb 21 18:17:19 alfred-player volumio[1250]: info: Adding plugin metavolumio to MyMusic Plugins Feb 21 18:17:19 alfred-player volumio[1250]: info: Adding plugin cd_controller to MyMusic Plugins Feb 21 18:17:19 alfred-player volumio[1250]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 21 18:17:19 alfred-player volumio[1250]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 21 18:17:19 alfred-player volumio[1250]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 21 18:17:19 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 21 18:17:20 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:20.803+01:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.13.107:52705 Feb 21 18:17:20 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:20.803+01:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.13.107:52705 Feb 21 18:17:20 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:20.813+01:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.13.107:52713 Feb 21 18:17:21 alfred-player volumio[1250]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 21 18:17:21 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 21 18:17:21 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:21 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:21 alfred-player volumio[1250]: info: Starting MyVolumio Remote Streaming Endpoints Feb 21 18:17:21 alfred-player volumio[1250]: info: MyVolumio login type: Token Feb 21 18:17:21 alfred-player volumio[1250]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 21 18:17:21 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 21 18:17:21 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:21.689+01:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.13.107:52713 @ 0x24c91d0" latency=69.308902ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Feb 21 18:17:24 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 21 18:17:24 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 21 18:17:24 alfred-player volumio[1250]: info: Streaming services startup Feb 21 18:17:24 alfred-player volumio[1250]: info: Starting Streaming Daemon Feb 21 18:17:24 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 21 18:17:24 alfred-player sudo[1773]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 21 18:17:24 alfred-player sudo[1773]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:24 alfred-player sudo[1773]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:24 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 18:17:24 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:24 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 18:17:24 alfred-player volumio[1250]: info: BOOT COMPLETED Feb 21 18:17:24 alfred-player volumio[1250]: info: Discovery: this is already registered, 23974f25-6875-4c2f-99d9-877d37c04f0e Feb 21 18:17:24 alfred-player volumio[1250]: info: Discovery: Found device Alfred Player Feb 21 18:17:24 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:24 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:24 alfred-player volumio[1250]: error: Cannot start Volumio Streaming Daemon Feb 21 18:17:24 alfred-player volumio[1250]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 21 18:17:24 alfred-player volumio[1250]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 21 18:17:25 alfred-player volumio[1250]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 21 18:17:26 alfred-player volumio-remote-updater[740]: Test mode disabled Feb 21 18:17:26 alfred-player volumio-remote-updater[740]: Alpha mode disabled Feb 21 18:17:26 alfred-player volumio-remote-updater[740]: Alpha legacy test mode disabled Feb 21 18:17:26 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 21 18:17:26 alfred-player volumio[1250]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 21 18:17:26 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 21 18:17:26 alfred-player volumio[1250]: info: MyVolumio token set successfully Feb 21 18:17:26 alfred-player volumio[1250]: info: MYVOLUMIO: Adding device Feb 21 18:17:26 alfred-player volumio[1250]: info: MYVOLUMIO: Evaluating Server Feb 21 18:17:26 alfred-player sudo[1786]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 18:17:26 alfred-player sudo[1786]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:26 alfred-player sudo[1786]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:26 alfred-player sudo[1788]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 18:17:26 alfred-player sudo[1788]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:26 alfred-player sudo[1788]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:27 alfred-player volumio[1250]: info: MyVolumio Plan changed: premium Feb 21 18:17:27 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Feb 21 18:17:27 alfred-player volumio[1250]: info: Removing browser output: myVolumio user plan is not superstar Feb 21 18:17:27 alfred-player volumio[1250]: info: Removing audio output: Feb 21 18:17:27 alfred-player volumio[1250]: info: MYVOLUMIO: Adding device Feb 21 18:17:27 alfred-player volumio[1250]: info: MYVOLUMIO: Evaluating Server Feb 21 18:17:27 alfred-player volumio[1250]: verbose: New Socket.io Connection to 192.168.13.106 from 192.168.13.107 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 Feb 21 18:17:27 alfred-player volumio[1250]: info: Remote config written successfully Feb 21 18:17:27 alfred-player volumio[1250]: info: Starting Tunnel 1 Feb 21 18:17:27 alfred-player volumio[1250]: info: Starting Tunnel Connection Checker Feb 21 18:17:27 alfred-player volumio[1250]: info: MYVolumio Device enabled Feb 21 18:17:27 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Feb 21 18:17:28 alfred-player volumio[1250]: info: MyVolumio status changed Feb 21 18:17:28 alfred-player volumio[1250]: info: Streaming services startup Feb 21 18:17:28 alfred-player volumio[1250]: info: Starting Streaming Daemon Feb 21 18:17:28 alfred-player sudo[1828]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 21 18:17:28 alfred-player sudo[1828]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:28 alfred-player volumio[1250]: info: Setting Geolocation for MyVolumio to eu6 Feb 21 18:17:28 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:28 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:28 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:28 alfred-player sudo[1828]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:28 alfred-player volumio[1250]: error: Cannot start Volumio Streaming Daemon Feb 21 18:17:28 alfred-player volumio[1250]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 21 18:17:28 alfred-player volumio[1250]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 21 18:17:28 alfred-player volumio[1250]: info: Setting Geolocation for MyVolumio to eu6 Feb 21 18:17:28 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:28 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:28 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:28 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Feb 21 18:17:28 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Feb 21 18:17:29 alfred-player systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4. Feb 21 18:17:29 alfred-player systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 21 18:17:29 alfred-player systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 21 18:17:29 alfred-player upmpdcli[1831]: Could not open config: /tmp/upmpdcli.conf Feb 21 18:17:29 alfred-player systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 21 18:17:29 alfred-player systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 21 18:17:29 alfred-player volumio[1250]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Feb 21 18:17:29 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Feb 21 18:17:30 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:30.035+01:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.13.107:52713 @ 0x24c91d0" latency=37.119015ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Feb 21 18:17:31 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:31.984+01:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.13.107:52713 error="websocket: close 1006 (abnormal closure): unexpected EOF" Feb 21 18:17:31 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:31.985+01:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.13.107:52713 Feb 21 18:17:31 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:31.985+01:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.13.107:52713 Feb 21 18:17:34 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Feb 21 18:17:34 alfred-player sudo[1848]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Feb 21 18:17:34 alfred-player sudo[1848]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:34 alfred-player sudo[1848]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:34 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:34.372+01:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.13.107:52715 Feb 21 18:17:34 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:34.454+01:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.13.107:52715 @ 0x25be6f0" latency=33.34591ms platform=PLATFORM_IOS version=5.260120.0 Feb 21 18:17:34 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:34.455+01:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.13.107:52715 @ 0x25be6f0" latency=33.422229ms timeout=10s Feb 21 18:17:34 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:34.455+01:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" Feb 21 18:17:34 alfred-player volumio[1250]: info: MRS: MultiRoom plugin initialized Feb 21 18:17:34 alfred-player volumio[1250]: info: MRS: STOPPING SNAPCLIENT Feb 21 18:17:34 alfred-player volumio[1250]: info: MRS: Snap server stop Feb 21 18:17:34 alfred-player volumio[1250]: info: MRS: STOPPING volumioStreaming Feb 21 18:17:34 alfred-player sudo[1865]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Feb 21 18:17:34 alfred-player sudo[1865]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:34 alfred-player sudo[1867]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Feb 21 18:17:34 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Feb 21 18:17:34 alfred-player sudo[1867]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:34 alfred-player sudo[1871]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Feb 21 18:17:34 alfred-player sudo[1871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:34 alfred-player sudo[1867]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:34 alfred-player sudo[1872]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Feb 21 18:17:34 alfred-player sudo[1872]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:34 alfred-player sudo[1865]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:34 alfred-player sudo[1872]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:34 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Feb 21 18:17:34 alfred-player sudo[1871]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:34 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Feb 21 18:17:35 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Feb 21 18:17:35 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Feb 21 18:17:35 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Feb 21 18:17:35 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Feb 21 18:17:35 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Feb 21 18:17:35 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Feb 21 18:17:35 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Feb 21 18:17:35 alfred-player volumio[1250]: info: Preparing to generate the ALSA configuration file Feb 21 18:17:35 alfred-player volumio[1250]: info: Updating MyVolumio device info Feb 21 18:17:35 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:35 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:35 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:35 alfred-player volumio[1250]: info: Updating MyVolumio device info Feb 21 18:17:35 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:35 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:35 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:35 alfred-player volumio[1250]: info: Successfully Added MyVolumio device Feb 21 18:17:35 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:35 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:35 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:35 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:35 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:35 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:35 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:35 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:35.821+01:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" name="Alfred Player" Feb 21 18:17:35 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:35.821+01:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" language=en Feb 21 18:17:35 alfred-player volumio[1250]: info: MRS: Removed streaming files Feb 21 18:17:35 alfred-player volumio[1250]: info: MRS: volumioStreaming STOPPED Feb 21 18:17:35 alfred-player volumio[1250]: info: MRS: SNAPSERVER STOPPED Feb 21 18:17:35 alfred-player volumio[1250]: info: MRS: SNAPCLIENT STOPPED Feb 21 18:17:35 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 21 18:17:35 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:35.966+01:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" timezone=Europe/Vienna Feb 21 18:17:35 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:35.967+01:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" available=true connected=true macAddress=dc:a6:32:5c:52:4a ip4Address=192.168.13.106/24 ip6Address= Feb 21 18:17:35 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:35.968+01:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Feb 21 18:17:35 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:35.969+01:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" setupComplete=true Feb 21 18:17:36 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Feb 21 18:17:36 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 21 18:17:36 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:36 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 18:17:36 alfred-player volumio[1250]: amixer -c 0 info | grep "bcm2835 ALSA" Feb 21 18:17:36 alfred-player volumio[1250]: amixer -c 1 info | grep "bcm2835 Headphones" Feb 21 18:17:36 alfred-player volumio[1250]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' Feb 21 18:17:36 alfred-player volumio[1250]: amixer -c 2 info | grep "vc4-hdmi-0" Feb 21 18:17:36 alfred-player volumio[1250]: Card sysdefault:2 'vc4hdmi0'/'vc4-hdmi-0' Feb 21 18:17:36 alfred-player volumio[1250]: amixer -c 3 info | grep "vc4-hdmi-1" Feb 21 18:17:36 alfred-player volumio[1250]: Card sysdefault:3 'vc4hdmi1'/'vc4-hdmi-1' Feb 21 18:17:36 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 21 18:17:36 alfred-player volumio[1250]: info: Asound.conf file unchanged, so no further update is needed Feb 21 18:17:36 alfred-player volumio[1250]: info: Output device has changed, restarting MPD Feb 21 18:17:36 alfred-player sudo[1906]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 18:17:36 alfred-player sudo[1906]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:36 alfred-player volumio[1250]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 21 18:17:36 alfred-player sudo[1906]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:36 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:36 alfred-player sudo[1908]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 18:17:36 alfred-player sudo[1908]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:36 alfred-player systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 21 18:17:36 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Feb 21 18:17:36 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Plugin bluetooth disabled by user. Not starting Feb 21 18:17:36 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Feb 21 18:17:36 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Plugin multiroom disabled by user. Not starting Feb 21 18:17:36 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Feb 21 18:17:37 alfred-player volumio[1250]: info: Adding METAVOLUMIO REST API Endpoints Feb 21 18:17:37 alfred-player volumio[1250]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Feb 21 18:17:37 alfred-player volumio[1250]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Feb 21 18:17:37 alfred-player volumio[1250]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Feb 21 18:17:37 alfred-player volumio[1250]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Feb 21 18:17:37 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Feb 21 18:17:37 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Feb 21 18:17:37 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting Feb 21 18:17:37 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Feb 21 18:17:37 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Plugin smart_inputs disabled by user. Not starting Feb 21 18:17:37 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Feb 21 18:17:37 alfred-player volumio[1250]: error: Hi Res Audio Failed Login: Missing Login Data Feb 21 18:17:37 alfred-player volumio[1250]: info: Adding HIGHRESAUDIO REST API Endpoints Feb 21 18:17:37 alfred-player volumio[1250]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Feb 21 18:17:37 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Feb 21 18:17:37 alfred-player volumio[1250]: info: Refreshing TIDAL token Feb 21 18:17:37 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Feb 21 18:17:37 alfred-player systemd[1]: mpd.service: Deactivated successfully. Feb 21 18:17:37 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Feb 21 18:17:37 alfred-player systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 21 18:17:37 alfred-player systemd[1]: mpd.service: Consumed 3.186s CPU time. Feb 21 18:17:37 alfred-player systemd[1]: mpd.socket: Deactivated successfully. Feb 21 18:17:37 alfred-player systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 21 18:17:37 alfred-player systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 21 18:17:37 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:37.200+01:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.13.107:52715 @ 0x25be6f0" latency=38.319529ms platform=PLATFORM_IOS version=5.260120.0 Feb 21 18:17:37 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:37.201+01:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.13.107:52715 @ 0x25be6f0" latency=37.170795ms timeout=10s Feb 21 18:17:37 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:37.201+01:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" Feb 21 18:17:37 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Feb 21 18:17:37 alfred-player volumio[1250]: info: [MyVolumio PluginManager] Plugin qobuzconnect disabled by user. Not starting Feb 21 18:17:37 alfred-player volumio[1250]: info: Stopping AccessToken refresher cron for QOBUZ Feb 21 18:17:37 alfred-player sudo[1915]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 21 18:17:37 alfred-player sudo[1915]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:37 alfred-player systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 21 18:17:37 alfred-player systemd[1]: Starting mpd.service - Music Player Daemon... Feb 21 18:17:37 alfred-player sudo[1917]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 18:17:37 alfred-player sudo[1917]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 18:17:37 alfred-player sudo[1915]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:37 alfred-player sudo[1917]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:37 alfred-player volumio[1250]: info: AccessToken refresher cron started for QOBUZ Feb 21 18:17:37 alfred-player volumio[1250]: info: Adding QOBUZ REST API Endpoints Feb 21 18:17:37 alfred-player volumio[1250]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4 Feb 21 18:17:37 alfred-player volumio[1250]: /bin/sh: 1: /usr/local/bin/alsacap: not found Feb 21 18:17:37 alfred-player volumio[1250]: {"cmd":"/usr/local/bin/alsacap -C 4","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 4\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Feb 21 18:17:37 alfred-player volumio[1250]: amixer -c 4 info | grep "snd_rpi_hifiberry_digi" Feb 21 18:17:37 alfred-player volumio[1250]: Card sysdefault:4 'sndrpihifiberry'/'snd_rpi_hifiberry_digi' Feb 21 18:17:37 alfred-player volumio[1250]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4 Feb 21 18:17:37 alfred-player volumio[1250]: /bin/sh: 1: /usr/local/bin/alsacap: not found Feb 21 18:17:37 alfred-player volumio[1250]: {"cmd":"/usr/local/bin/alsacap -C 4","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 4\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Feb 21 18:17:37 alfred-player volumio[1250]: amixer -c 4 info | grep "HiFiBerry Digi" Feb 21 18:17:38 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:38.072+01:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" selectedOutputId=4 Feb 21 18:17:38 alfred-player volumio[1250]: info: Successfully Updated MyVolumio device Feb 21 18:17:38 alfred-player volumio[1250]: info: Successfully Added MyVolumio device Feb 21 18:17:38 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:38 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:38 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:38 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:38 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:38 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:38 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:38.348+01:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" currentVersion=4.096 latestVersion=4.096 Feb 21 18:17:38 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:38.348+01:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" status=UPDATE_STATUS_NONE progress=0 Feb 21 18:17:38 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:38.348+01:00 level=INFO msg="emitting user changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" userId= Feb 21 18:17:38 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:38.348+01:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" providers=3 Feb 21 18:17:38 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:38.349+01:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" name="Alfred Player" Feb 21 18:17:38 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:38.350+01:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" language=en Feb 21 18:17:38 alfred-player volumio[1250]: info: MPD Permissions set Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:17:38 alfred-player sudo[1930]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Feb 21 18:17:38 alfred-player sudo[1930]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 21 18:17:38 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:38.644+01:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" timezone=Europe/Vienna Feb 21 18:17:38 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:38.646+01:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" available=true connected=true macAddress=dc:a6:32:5c:52:4a ip4Address=192.168.13.106/24 ip6Address= Feb 21 18:17:38 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:38.651+01:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Feb 21 18:17:38 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:38.652+01:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" setupComplete=true Feb 21 18:17:38 alfred-player volumio[1250]: info: Successfully Updated MyVolumio device Feb 21 18:17:38 alfred-player systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 21 18:17:38 alfred-player systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Feb 21 18:17:38 alfred-player systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 21 18:17:38 alfred-player sudo[1930]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:38 alfred-player autossh[1933]: port set to 0, monitoring disabled Feb 21 18:17:38 alfred-player autossh[1933]: starting ssh (count 1) Feb 21 18:17:38 alfred-player autossh[1933]: ssh child pid is 1936 Feb 21 18:17:38 alfred-player mpd[1920]: 2026-02-21T18:17:38 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 21 18:17:38 alfred-player systemd[1]: Started mpd.service - Music Player Daemon. Feb 21 18:17:38 alfred-player sudo[1908]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 18:17:38 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:17:38 alfred-player volumio[1250]: amixer -c 0 info | grep "bcm2835 ALSA" Feb 21 18:17:39 alfred-player volumiossh-tunnel[1936]: Warning: Permanently added '[eu6.myvolumio.org]:2222' (RSA) to the list of known hosts. Feb 21 18:17:39 alfred-player volumio[1250]: amixer -c 1 info | grep "bcm2835 Headphones" Feb 21 18:17:39 alfred-player volumio[1250]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' Feb 21 18:17:39 alfred-player volumio[1250]: amixer -c 2 info | grep "vc4-hdmi-0" Feb 21 18:17:39 alfred-player volumio[1250]: Card sysdefault:2 'vc4hdmi0'/'vc4-hdmi-0' Feb 21 18:17:39 alfred-player volumio[1250]: amixer -c 3 info | grep "vc4-hdmi-1" Feb 21 18:17:39 alfred-player volumio[1250]: Card sysdefault:3 'vc4hdmi1'/'vc4-hdmi-1' Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:39 alfred-player volumio[1250]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4 Feb 21 18:17:39 alfred-player volumio[1250]: /bin/sh: 1: /usr/local/bin/alsacap: not found Feb 21 18:17:39 alfred-player volumio[1250]: {"cmd":"/usr/local/bin/alsacap -C 4","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 4\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Feb 21 18:17:39 alfred-player volumio[1250]: amixer -c 4 info | grep "snd_rpi_hifiberry_digi" Feb 21 18:17:39 alfred-player volumio[1250]: Card sysdefault:4 'sndrpihifiberry'/'snd_rpi_hifiberry_digi' Feb 21 18:17:39 alfred-player volumio[1250]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4 Feb 21 18:17:39 alfred-player volumio[1250]: /bin/sh: 1: /usr/local/bin/alsacap: not found Feb 21 18:17:39 alfred-player volumio[1250]: {"cmd":"/usr/local/bin/alsacap -C 4","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 4\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Feb 21 18:17:39 alfred-player volumio[1250]: amixer -c 4 info | grep "HiFiBerry Digi" Feb 21 18:17:39 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:39.645+01:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" selectedOutputId=4 Feb 21 18:17:39 alfred-player volumio[1250]: info: Remote SSH Started Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:39 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:39 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:39 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:40 alfred-player volumio[1250]: info: Access Token successfully retrieved Feb 21 18:17:40 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:40 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:40 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:40 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:40 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:40 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:40 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:40 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:40.404+01:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" currentVersion=4.096 latestVersion=4.096 Feb 21 18:17:40 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:40.404+01:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" status=UPDATE_STATUS_NONE progress=0 Feb 21 18:17:40 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:40.404+01:00 level=INFO msg="emitting user changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" userId= Feb 21 18:17:40 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:40.404+01:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" providers=3 Feb 21 18:17:40 alfred-player volumio[1250]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 21 18:17:40 alfred-player volumio[1250]: info: TidalConnect service stoped! Feb 21 18:17:40 alfred-player volumio[1250]: error: updateQueue error: null Feb 21 18:17:40 alfred-player volumio[1250]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 21 18:17:41 alfred-player volumio[1250]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 21 18:17:41 alfred-player volumio[1250]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:41 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:41 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:41 alfred-player volumio[1250]: info: Successfully retrieved User Session From TIDAL Feb 21 18:17:41 alfred-player sudo[1984]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 21 18:17:41 alfred-player sudo[1984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:41 alfred-player systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Feb 21 18:17:41 alfred-player volumio[1250]: verbose: New Socket.io Connection to 192.168.13.106:3000 from 192.168.13.107 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 21 18:17:41 alfred-player sudo[1984]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetBrowseSources Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 18:17:41 alfred-player volumio[1250]: info: Successfully retrieved User Subscription From TIDAL Feb 21 18:17:41 alfred-player volumio[1250]: info: Adding TIDAL to Browse Sources Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 21 18:17:41 alfred-player volumio[1250]: info: [1771694261888] CoreMusicLibrary::Adding element TIDAL Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 18:17:41 alfred-player volumio[1250]: Cannot find translation for source TIDAL Feb 21 18:17:41 alfred-player volumio[1250]: info: Adding TIDAL REST API Endpoints Feb 21 18:17:41 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:41.899+01:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" plugins=60 Feb 21 18:17:41 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:41.900+01:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" plugins=60 Feb 21 18:17:41 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:41 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:42 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:42 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:42 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:42 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:42 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:42.061+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 21 18:17:42 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:42.061+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" id=tidal://song/448913413 title="Hooker Thing" Feb 21 18:17:42 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:42.062+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 21 18:17:42 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:42.062+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" id=tidal://song/448913413 title="Hooker Thing" Feb 21 18:17:42 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:42.062+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 21 18:17:42 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:42.063+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" id=tidal://song/448913413 title="Hooker Thing" Feb 21 18:17:42 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:42.101+01:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.13.107:52715 @ 0x25be6f0" latency=39.056503ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Feb 21 18:17:42 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:42 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:42 alfred-player volumio[1250]: info: Executing endpoint tc_getconfig Feb 21 18:17:42 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 21 18:17:42 alfred-player vtcs[1987]: STARTING TidalConnect services, version: 1.6.1 Feb 21 18:17:42 alfred-player vtcs[1987]: STARTED TidalConnect services. Feb 21 18:17:42 alfred-player volumio[1250]: info: Executing endpoint tc_connect Feb 21 18:17:42 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 21 18:17:42 alfred-player volumio[1250]: info: Connecting to TidalConnect Feb 21 18:17:42 alfred-player volumio[1250]: info: CoreCommandRouter::servicePushState Feb 21 18:17:42 alfred-player volumio[1250]: info: CoreStateMachine::pushState Feb 21 18:17:42 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:42 alfred-player volumio[1250]: info: CoreCommandRouter::volumioPushState Feb 21 18:17:42 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:42 alfred-player volumio[1250]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Feb 21 18:17:42 alfred-player volumio[1250]: info: CoreCommandRouter::servicePushState Feb 21 18:17:42 alfred-player volumio[1250]: info: CoreStateMachine::pushState Feb 21 18:17:42 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:42 alfred-player volumio[1250]: info: CoreCommandRouter::volumioPushState Feb 21 18:17:42 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:42 alfred-player volumio[1250]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Feb 21 18:17:42 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:42.616+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 21 18:17:42 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:42.616+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" id=tidal://song/448913413 title="Hooker Thing" Feb 21 18:17:42 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:42.628+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 21 18:17:42 alfred-player volumio5-onboarding[1495]: time=2026-02-21T18:17:42.628+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.13.107:52715 @ 0x25be6f0" id=tidal://song/448913413 title="Hooker Thing" Feb 21 18:17:43 alfred-player sudo[2004]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 18:17:43 alfred-player sudo[2004]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:43 alfred-player sudo[2004]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:43 alfred-player sudo[2007]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 18:17:43 alfred-player sudo[2007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:43 alfred-player sudo[2007]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:43 alfred-player volumio[1250]: verbose: New Socket.io Connection to 192.168.13.106 from 192.168.13.107 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: 11 Feb 21 18:17:43 alfred-player sudo[2010]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 18:17:43 alfred-player sudo[2010]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:43 alfred-player sudo[2012]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 18:17:43 alfred-player sudo[2012]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:43 alfred-player sudo[2010]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:43 alfred-player sudo[2012]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:43 alfred-player volumio[1250]: verbose: New Socket.io Connection to 192.168.13.106 from 192.168.13.107 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: 12 Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetVisibleSources Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:44 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 21 18:17:44 alfred-player volumio[1250]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 21 18:17:44 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:44 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:44 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:44 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:44 alfred-player volumio[1250]: info: Listing playlists Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 21 18:17:44 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 21 18:17:44 alfred-player systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 5. Feb 21 18:17:44 alfred-player systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 21 18:17:44 alfred-player systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 21 18:17:44 alfred-player upmpdcli[2029]: Could not open config: /tmp/upmpdcli.conf Feb 21 18:17:44 alfred-player systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 21 18:17:44 alfred-player systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 21 18:17:44 alfred-player volumio[1250]: info: TidalConnect service started! Feb 21 18:17:45 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:17:45 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:45 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:45 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:45 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:45 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:45 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:45 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:45 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 21 18:17:46 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:17:46 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 18:17:47 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:17:47 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:17:47 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:17:47 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:17:47 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:17:47 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:17:47 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:17:47 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:17:50 alfred-player volumio[1250]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:17:50 alfred-player volumio[1250]: info: touch_display: About to detect HDMI ports... Feb 21 18:17:50 alfred-player volumio[1250]: info: touch_display: X server not ready, cannot detect HDMI ports yet. Feb 21 18:17:53 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 21 18:17:54 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:17:54 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 18:17:56 alfred-player volumio[1250]: info: Enabling plugin touch_display Feb 21 18:17:56 alfred-player volumio[1250]: info: Loading plugin "touch_display"... Feb 21 18:17:56 alfred-player volumio[1250]: info: Applying required configuration parameters for plugin touch_display Feb 21 18:17:56 alfred-player volumio[1250]: info: PLUGIN START: touch_display Feb 21 18:17:56 alfred-player volumio[1250]: info: Loading i18n strings for locale en Feb 21 18:17:56 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 18:17:56 alfred-player sudo[2047]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge Feb 21 18:17:56 alfred-player sudo[2047]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:56 alfred-player sudo[2047]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:56 alfred-player volumio[1250]: info: touch_display: No backlight interface detected. Feb 21 18:17:56 alfred-player sudo[2049]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Feb 21 18:17:56 alfred-player sudo[2049]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:56 alfred-player sudo[2053]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Feb 21 18:17:56 alfred-player sudo[2053]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:56 alfred-player sudo[2054]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Feb 21 18:17:56 alfred-player sudo[2054]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:56 alfred-player sudo[2057]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/ Feb 21 18:17:56 alfred-player sudo[2057]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:56 alfred-player volumio[1250]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Feb 21 18:17:56 alfred-player systemd[1]: Reloading. Feb 21 18:17:56 alfred-player sudo[2062]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Feb 21 18:17:56 alfred-player sudo[2062]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:56 alfred-player sudo[2057]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:56 alfred-player sudo[2062]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:56 alfred-player volumio[1250]: info: touch_display: IframeKeyboardBridge extension installed successfully Feb 21 18:17:57 alfred-player volumio[1250]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Feb 21 18:17:57 alfred-player systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 21 18:17:57 alfred-player systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 21 18:17:57 alfred-player systemd[1]: Reloading. Feb 21 18:17:57 alfred-player sudo[2054]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:57 alfred-player volumio[1250]: info: touch_display: systemctl daemon-reload succeeded. Feb 21 18:17:58 alfred-player sudo[2083]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Feb 21 18:17:58 alfred-player sudo[2083]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:17:58 alfred-player systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 21 18:17:58 alfred-player systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 21 18:17:58 alfred-player sudo[2083]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:58 alfred-player volumio[1250]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service Feb 21 18:17:58 alfred-player volumio[1250]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found. Feb 21 18:17:58 alfred-player sudo[2053]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:58 alfred-player sudo[2049]: pam_unix(sudo:session): session closed for user root Feb 21 18:17:59 alfred-player volumio[1250]: info: Error: Error Feb 21 18:17:59 alfred-player volumio[1250]: info: touch_display: systemctl stop getty@tty1.service succeeded. Feb 21 18:17:59 alfred-player volumio[1250]: info: touch_display: systemctl disable getty@tty1.service succeeded. Feb 21 18:17:59 alfred-player systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 6. Feb 21 18:17:59 alfred-player systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 21 18:17:59 alfred-player systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 21 18:17:59 alfred-player upmpdcli[2102]: Could not open config: /tmp/upmpdcli.conf Feb 21 18:17:59 alfred-player systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 21 18:17:59 alfred-player systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 21 18:18:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 21 18:18:02 alfred-player volumio[1250]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 21 18:18:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 21 18:18:02 alfred-player volumio[1250]: info: Received Get System Version Feb 21 18:18:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 18:18:02 alfred-player volumio[1250]: info: Received Get System Info Feb 21 18:18:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 18:18:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 18:18:02 alfred-player volumio[1250]: info: Discovery: Getting this device information Feb 21 18:18:02 alfred-player volumio[1250]: info: CoreCommandRouter::volumioGetState Feb 21 18:18:02 alfred-player volumio[1250]: info: CorePlayQueue::getTrack 0 Feb 21 18:18:02 alfred-player volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 18:18:03 alfred-player volumio[1250]: info: Starting Uninstall of plugin user_interface - touch_display Feb 21 18:18:03 alfred-player volumio[1250]: info: Uninstalling plugin touch_display Feb 21 18:18:03 alfred-player sudo[2105]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Feb 21 18:18:03 alfred-player sudo[2105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:18:03 alfred-player sudo[2105]: pam_unix(sudo:session): session closed for user root Feb 21 18:18:03 alfred-player sudo[2107]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Feb 21 18:18:03 alfred-player sudo[2107]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:18:04 alfred-player volumio[1250]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Feb 21 18:18:04 alfred-player volumio[1250]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 18:18:04 alfred-player sudo[2111]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Feb 21 18:18:04 alfred-player sudo[2111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:18:04 alfred-player volumio[1250]: TypeError: Cannot read properties of undefined (reading 'split') Feb 21 18:18:04 alfred-player volumio[1250]: at /data/plugins/user_interface/touch_display/index.js:1298:37 Feb 21 18:18:04 alfred-player volumio[1250]: at ChildProcess.exithandler (node:child_process:413:7) Feb 21 18:18:04 alfred-player volumio[1250]: at ChildProcess.emit (node:events:514:28) Feb 21 18:18:04 alfred-player volumio[1250]: at maybeClose (node:internal/child_process:1105:16) Feb 21 18:18:04 alfred-player volumio[1250]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) Feb 21 18:18:04 alfred-player volumio[1250]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 18:18:04 alfred-player sudo[2112]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Feb 21 18:18:04 alfred-player sudo[2112]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:18:04 alfred-player sudo[2111]: pam_unix(sudo:session): session closed for user root Feb 21 18:18:04 alfred-player systemd[1]: Created slice system-getty.slice - Slice /system/getty. Feb 21 18:18:04 alfred-player systemd[1]: Started getty@tty1.service - Getty on tty1. Feb 21 18:18:04 alfred-player systemd[1]: Reloading. Feb 21 18:18:05 alfred-player systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 21 18:18:05 alfred-player systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 21 18:18:05 alfred-player sudo[2107]: pam_unix(sudo:session): session closed for user root Feb 21 18:18:05 alfred-player sudo[2112]: pam_unix(sudo:session): session closed for user root Feb 21 18:18:07 alfred-player sudo[2162]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-21 18:17' Feb 21 18:18:07 alfred-player sudo[2162]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"