Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.597+03:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.168.8:37330 Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.723+03:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.168.8:37330 @ 0x2c00bd0" latency=290.206077ms platform=PLATFORM_ANDROID version=5.260331.0 Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.740+03:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.168.8:37330 @ 0x2c00bd0" latency=305.21074ms timeout=10s Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.740+03:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" Apr 15 15:48:54 streamer volumio[1260]: info: Received Get System Info Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 15:48:54 streamer volumio[1260]: info: Discovery: Getting this device information Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:48:54 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.744+03:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" name=Streamer Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.747+03:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" language=ru Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.750+03:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" timezone=Europe/Riga Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.751+03:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" available=true connected=false macAddress= ip4Address= ip6Address= Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.755+03:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" available=true connected=true macAddress=e4:5f:01:48:11:43 ip4Address=192.168.168.20/24 ip6Address= ssid=Mont Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.755+03:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" setupComplete=true Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 15 15:48:54 streamer volumio[1260]: amixer -c 0 info | grep "bcm2835 ALSA" Apr 15 15:48:54 streamer volumio[1260]: amixer -c 1 info | grep "bcm2835 Headphones" Apr 15 15:48:54 streamer volumio[1260]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' Apr 15 15:48:54 streamer volumio[1260]: amixer -c 2 info | grep "vc4-hdmi-0" Apr 15 15:48:54 streamer volumio[1260]: Card sysdefault:2 'vc4hdmi0'/'vc4-hdmi-0' Apr 15 15:48:54 streamer volumio[1260]: amixer -c 3 info | grep "vc4-hdmi-1" Apr 15 15:48:54 streamer volumio[1260]: Card sysdefault:3 'vc4hdmi1'/'vc4-hdmi-1' Apr 15 15:48:54 streamer volumio[1260]: amixer -c 4 info | grep "snd_rpi_hifiberry_dacplus" Apr 15 15:48:54 streamer volumio[1260]: Card sysdefault:4 'sndrpihifiberry'/'snd_rpi_hifiberry_dacplus' Apr 15 15:48:54 streamer volumio[1260]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4 Apr 15 15:48:54 streamer volumio[1260]: /bin/sh: 1: /usr/local/bin/alsacap: not found Apr 15 15:48:54 streamer volumio[1260]: {"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)"} Apr 15 15:48:54 streamer volumio[1260]: amixer -c 4 info | grep "HiFiBerry DAC+ Pro" Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.894+03:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" selectedOutputId=4 Apr 15 15:48:54 streamer volumio[1260]: info: Received Get System Info Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 15:48:54 streamer volumio[1260]: info: Discovery: Getting this device information Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:48:54 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.912+03:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" currentVersion=4.119 latestVersion=4.119 Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.913+03:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" status=UPDATE_STATUS_NONE progress=0 Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.913+03:00 level=INFO msg="emitting user changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" userId= Apr 15 15:48:54 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:54.913+03:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" providers=3 Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 15 15:48:54 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.760+03:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.168.8:37330 @ 0x2c00bd0" latency=393.060509ms platform=PLATFORM_ANDROID version=5.260331.0 Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.812+03:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.168.8:37330 @ 0x2c00bd0" latency=443.379721ms timeout=10s Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.812+03:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" Apr 15 15:48:56 streamer volumio[1260]: info: Received Get System Info Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 15:48:56 streamer volumio[1260]: info: Discovery: Getting this device information Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:48:56 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.817+03:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" name=Streamer Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.818+03:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" language=ru Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.820+03:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" timezone=Europe/Riga Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.821+03:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" available=true connected=false macAddress= ip4Address= ip6Address= Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.824+03:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" available=true connected=true macAddress=e4:5f:01:48:11:43 ip4Address=192.168.168.20/24 ip6Address= ssid=Mont Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.824+03:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" setupComplete=true Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 15 15:48:56 streamer volumio[1260]: amixer -c 0 info | grep "bcm2835 ALSA" Apr 15 15:48:56 streamer volumio[1260]: amixer -c 1 info | grep "bcm2835 Headphones" Apr 15 15:48:56 streamer volumio[1260]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' Apr 15 15:48:56 streamer volumio[1260]: amixer -c 2 info | grep "vc4-hdmi-0" Apr 15 15:48:56 streamer volumio[1260]: Card sysdefault:2 'vc4hdmi0'/'vc4-hdmi-0' Apr 15 15:48:56 streamer volumio[1260]: amixer -c 3 info | grep "vc4-hdmi-1" Apr 15 15:48:56 streamer volumio[1260]: Card sysdefault:3 'vc4hdmi1'/'vc4-hdmi-1' Apr 15 15:48:56 streamer volumio[1260]: amixer -c 4 info | grep "snd_rpi_hifiberry_dacplus" Apr 15 15:48:56 streamer volumio[1260]: Card sysdefault:4 'sndrpihifiberry'/'snd_rpi_hifiberry_dacplus' Apr 15 15:48:56 streamer volumio[1260]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4 Apr 15 15:48:56 streamer volumio[1260]: /bin/sh: 1: /usr/local/bin/alsacap: not found Apr 15 15:48:56 streamer volumio[1260]: {"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)"} Apr 15 15:48:56 streamer volumio[1260]: amixer -c 4 info | grep "HiFiBerry DAC+ Pro" Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.956+03:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" selectedOutputId=4 Apr 15 15:48:56 streamer volumio[1260]: info: Received Get System Info Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 15:48:56 streamer volumio[1260]: info: Discovery: Getting this device information Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:48:56 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:48:56 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.969+03:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" currentVersion=4.119 latestVersion=4.119 Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.970+03:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" status=UPDATE_STATUS_NONE progress=0 Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.970+03:00 level=INFO msg="emitting user changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" userId= Apr 15 15:48:56 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:56.970+03:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" providers=3 Apr 15 15:48:57 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:57.152+03:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" plugins=69 Apr 15 15:48:57 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:57.153+03:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" plugins=69 Apr 15 15:48:57 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:48:57 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:48:57 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:57.157+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:48:57 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:48:57 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:57.157+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:48:57 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:57.157+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:48:57 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:57.158+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:48:57 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:48:57 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:57.160+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:48:57 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:57.160+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:48:57 streamer volumio5-onboarding[1539]: time=2026-04-15T15:48:57.207+03:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.168.8:37330 @ 0x2c00bd0" latency=297.318277ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Apr 15 15:48:59 streamer sudo[2265]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 15 15:48:59 streamer sudo[2265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 15 15:48:59 streamer sudo[2267]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 15 15:48:59 streamer sudo[2265]: pam_unix(sudo:session): session closed for user root Apr 15 15:48:59 streamer sudo[2267]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 15 15:48:59 streamer sudo[2267]: pam_unix(sudo:session): session closed for user root Apr 15 15:48:59 streamer volumio[1260]: verbose: New Socket.io Connection to 192.168.168.20 from 192.168.168.8 UA: Mozilla/5.0 (Linux; Android 11; SM-A505FN Build/RP1A.200720.012; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.177 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Apr 15 15:49:00 streamer sudo[2271]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 15 15:49:00 streamer sudo[2271]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 15 15:49:00 streamer sudo[2271]: pam_unix(sudo:session): session closed for user root Apr 15 15:49:00 streamer sudo[2273]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 15 15:49:00 streamer sudo[2273]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 15 15:49:00 streamer sudo[2273]: pam_unix(sudo:session): session closed for user root Apr 15 15:49:00 streamer volumio[1260]: verbose: New Socket.io Connection to 192.168.168.20 from 192.168.168.8 UA: Mozilla/5.0 (Linux; Android 11; SM-A505FN Build/RP1A.200720.012; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.177 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Apr 15 15:49:00 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 15 15:49:00 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::volumioGetVisibleSources Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:49:01 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 15 15:49:01 streamer volumio[1260]: info: Received Get System Info Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 15:49:01 streamer volumio[1260]: info: Discovery: Getting this device information Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:49:01 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:49:01 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:01 streamer volumio[1260]: info: Listing playlists Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 15 15:49:01 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 15 15:49:02 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 15 15:49:02 streamer volumio[1260]: info: Received Get System Info Apr 15 15:49:02 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 15:49:02 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 15:49:02 streamer volumio[1260]: info: Discovery: Getting this device information Apr 15 15:49:02 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:49:02 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:02 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 15:49:02 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 15 15:49:03 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 15 15:49:03 streamer volumio[1260]: info: Received Get System Info Apr 15 15:49:03 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 15:49:03 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 15:49:03 streamer volumio[1260]: info: Discovery: Getting this device information Apr 15 15:49:03 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:49:03 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:03 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 15:49:04 streamer volumio[1260]: info: Retrieving Cloud Streaming UI Apr 15 15:49:04 streamer volumio[1260]: info: Getting Tidal Cloud Configuration Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 15:49:04 streamer volumio[1260]: info: Getting Qobuz Cloud Configuration Apr 15 15:49:04 streamer volumio[1260]: info: Asking plugin for UI Config Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 15:49:04 streamer volumio[1260]: info: Getting Spotify Cloud Configuration Apr 15 15:49:04 streamer volumio[1260]: info: Asking plugin for UI Config Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 15:49:04 streamer volumio[1260]: info: Saving Spotify Acccount Apr 15 15:49:04 streamer volumio[1260]: info: Got Tidal Cloud Configuration Apr 15 15:49:04 streamer volumio[1260]: info: Got it Apr 15 15:49:04 streamer volumio[1260]: info: Got it Apr 15 15:49:04 streamer volumio[1260]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 15:49:04 streamer volumio[1260]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::volumioGetBrowseSources Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::volumioGetBrowseSources Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::volumioGetBrowseSources Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 15:49:04 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 15 15:49:08 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 15:49:10 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand update Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:12 streamer volumio[1260]: info: Apr 15 15:49:12 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:12 streamer volumio[1260]: info: sendMpdCommand update took 5 milliseconds Apr 15 15:49:12 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:12 streamer volumio[1260]: info: sendMpdCommand status took 4 milliseconds Apr 15 15:49:12 streamer volumio[1260]: info: sendMpdCommand status took 2 milliseconds Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:12 streamer volumio[1260]: info: Command Router : Notfying DB Updatetrue Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:12 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:12 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:12 streamer volumio[1260]: info: No code Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.874+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.874+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.874+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.875+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.876+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.877+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:12 streamer volumio[1260]: info: ------------------------------ 85ms Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:12 streamer volumio[1260]: info: Apr 15 15:49:12 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:12 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:12 streamer volumio[1260]: info: Apr 15 15:49:12 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:12 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:12 streamer volumio[1260]: info: sendMpdCommand status took 3 milliseconds Apr 15 15:49:12 streamer volumio[1260]: info: sendMpdCommand status took 2 milliseconds Apr 15 15:49:12 streamer volumio[1260]: info: sendMpdCommand status took 3 milliseconds Apr 15 15:49:12 streamer volumio[1260]: info: sendMpdCommand status took 2 milliseconds Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:12 streamer volumio[1260]: info: Command Router : Notfying DB Updatetrue Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::Close All Modals sent Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:12 streamer volumio[1260]: info: Command Router : Notfying DB Updatetrue Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::Close All Modals sent Apr 15 15:49:12 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:12 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:12 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:12 streamer volumio[1260]: info: No code Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:12 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:12 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:12 streamer volumio[1260]: info: No code Apr 15 15:49:12 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:12 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:12 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.951+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.951+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.953+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.954+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.955+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.956+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.958+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.958+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.959+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.960+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.961+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:12 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:12.961+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:12 streamer volumio[1260]: info: ------------------------------ 91ms Apr 15 15:49:12 streamer volumio[1260]: info: ------------------------------ 91ms Apr 15 15:49:13 streamer volumio[1260]: info: MPD Database updated - AlbumList cache refreshed Apr 15 15:49:13 streamer volumio[1260]: info: Apr 15 15:49:13 streamer volumio[1260]: ---------------------------- MPD announces state update: database Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:13 streamer volumio[1260]: info: Apr 15 15:49:13 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:13 streamer volumio[1260]: info: MPD Database updated - AlbumList cache refreshed Apr 15 15:49:13 streamer volumio[1260]: info: Apr 15 15:49:13 streamer volumio[1260]: ---------------------------- MPD announces state update: database Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:13 streamer volumio[1260]: info: Apr 15 15:49:13 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:13 streamer volumio[1260]: info: MPD Database updated - AlbumList cache refreshed Apr 15 15:49:13 streamer volumio[1260]: info: Apr 15 15:49:13 streamer volumio[1260]: ---------------------------- MPD announces state update: database Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:13 streamer volumio[1260]: info: Apr 15 15:49:13 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:13 streamer volumio[1260]: info: sendMpdCommand status took 88 milliseconds Apr 15 15:49:13 streamer volumio[1260]: info: sendMpdCommand status took 88 milliseconds Apr 15 15:49:13 streamer volumio[1260]: info: sendMpdCommand status took 87 milliseconds Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:13 streamer volumio[1260]: info: Command Router : Notfying DB Updatefalse Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::Close All Modals sent Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:13 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: No code Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:13 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: No code Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.493+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.494+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.495+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.495+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.496+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.497+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.497+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.497+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.499+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.499+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.500+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.500+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio[1260]: info: ------------------------------ 182ms Apr 15 15:49:13 streamer volumio[1260]: info: ------------------------------ 183ms Apr 15 15:49:13 streamer volumio[1260]: info: sendMpdCommand status took 226 milliseconds Apr 15 15:49:13 streamer volumio[1260]: info: sendMpdCommand status took 225 milliseconds Apr 15 15:49:13 streamer volumio[1260]: info: sendMpdCommand status took 225 milliseconds Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:13 streamer volumio[1260]: info: Command Router : Notfying DB Updatefalse Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::Close All Modals sent Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:13 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: No code Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:13 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: No code Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.595+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.596+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.596+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.596+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.598+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.598+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.600+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.600+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.604+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.604+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.605+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.606+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio[1260]: info: ------------------------------ 285ms Apr 15 15:49:13 streamer volumio[1260]: info: ------------------------------ 285ms Apr 15 15:49:13 streamer volumio[1260]: info: sendMpdCommand status took 346 milliseconds Apr 15 15:49:13 streamer volumio[1260]: info: sendMpdCommand status took 345 milliseconds Apr 15 15:49:13 streamer volumio[1260]: info: sendMpdCommand status took 344 milliseconds Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:13 streamer volumio[1260]: info: Command Router : Notfying DB Updatefalse Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::Close All Modals sent Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:13 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:13 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: No code Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:13 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio[1260]: info: No code Apr 15 15:49:13 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:13 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:13 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.719+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.719+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.721+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.721+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.722+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.723+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.724+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.724+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.725+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.725+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.726+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:13 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:13.727+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:13 streamer volumio[1260]: info: ------------------------------ 402ms Apr 15 15:49:13 streamer volumio[1260]: info: ------------------------------ 402ms Apr 15 15:49:16 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 15:49:18 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 15 15:49:18 streamer volumio[1260]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 15 15:49:18 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 15 15:49:18 streamer volumio[1260]: info: Received Get System Version Apr 15 15:49:18 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 15 15:49:18 streamer volumio[1260]: info: Received Get System Info Apr 15 15:49:18 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 15:49:18 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 15:49:18 streamer volumio[1260]: info: Discovery: Getting this device information Apr 15 15:49:18 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:49:18 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:18 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 15:49:20 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 15:49:24 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand rescan Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:26 streamer volumio[1260]: info: Apr 15 15:49:26 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:26 streamer volumio[1260]: info: sendMpdCommand rescan took 5 milliseconds Apr 15 15:49:26 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:26 streamer volumio[1260]: info: sendMpdCommand status took 4 milliseconds Apr 15 15:49:26 streamer volumio[1260]: info: sendMpdCommand status took 2 milliseconds Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:26 streamer volumio[1260]: info: Command Router : Notfying DB Updatetrue Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::Close All Modals sent Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:26 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:26 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:26 streamer volumio[1260]: info: No code Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.259+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.259+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.260+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.261+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.261+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.262+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:26 streamer volumio[1260]: info: ------------------------------ 79ms Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:26 streamer volumio[1260]: info: Apr 15 15:49:26 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:26 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:26 streamer volumio[1260]: info: Apr 15 15:49:26 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:26 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:26 streamer volumio[1260]: info: sendMpdCommand status took 3 milliseconds Apr 15 15:49:26 streamer volumio[1260]: info: sendMpdCommand status took 2 milliseconds Apr 15 15:49:26 streamer volumio[1260]: info: sendMpdCommand status took 2 milliseconds Apr 15 15:49:26 streamer volumio[1260]: info: sendMpdCommand status took 2 milliseconds Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:26 streamer volumio[1260]: info: Command Router : Notfying DB Updatetrue Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::Close All Modals sent Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:26 streamer volumio[1260]: info: Command Router : Notfying DB Updatetrue Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::Close All Modals sent Apr 15 15:49:26 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:26 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:26 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:26 streamer volumio[1260]: info: No code Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:26 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:26 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:26 streamer volumio[1260]: info: No code Apr 15 15:49:26 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:26 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:26 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.328+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.328+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.329+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.330+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.331+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.331+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.332+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.332+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.333+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.334+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.334+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:26 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:26.335+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:26 streamer volumio[1260]: info: ------------------------------ 80ms Apr 15 15:49:26 streamer volumio[1260]: info: ------------------------------ 78ms Apr 15 15:49:28 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 15:49:31 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 15:49:31 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 15:49:31 streamer volumio[1260]: info: Discovery: Getting this device information Apr 15 15:49:31 streamer volumio[1260]: info: CoreCommandRouter::volumioGetState Apr 15 15:49:31 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:31 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 15:49:31 streamer volumio[1260]: verbose: New Socket.io Connection to 192.168.168.20:3000 from 192.168.168.8 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Apr 15 15:49:31 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 15 15:49:31 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 15 15:49:32 streamer volumio[1260]: info: MPD Database updated - AlbumList cache refreshed Apr 15 15:49:32 streamer volumio[1260]: info: Apr 15 15:49:32 streamer volumio[1260]: ---------------------------- MPD announces state update: database Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:32 streamer volumio[1260]: info: Apr 15 15:49:32 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:32 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:32 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:32 streamer volumio[1260]: info: MPD Database updated - AlbumList cache refreshed Apr 15 15:49:32 streamer volumio[1260]: info: Apr 15 15:49:32 streamer volumio[1260]: ---------------------------- MPD announces state update: database Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:32 streamer volumio[1260]: info: Apr 15 15:49:32 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:32 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:32 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:32 streamer volumio[1260]: info: MPD Database updated - AlbumList cache refreshed Apr 15 15:49:32 streamer volumio[1260]: info: Apr 15 15:49:32 streamer volumio[1260]: ---------------------------- MPD announces state update: database Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:32 streamer volumio[1260]: info: Apr 15 15:49:32 streamer volumio[1260]: ---------------------------- MPD announces state update: update Apr 15 15:49:32 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:32 streamer volumio[1260]: info: ControllerMpd::getState Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Apr 15 15:49:32 streamer volumio[1260]: info: sendMpdCommand status took 87 milliseconds Apr 15 15:49:32 streamer volumio[1260]: info: sendMpdCommand status took 86 milliseconds Apr 15 15:49:32 streamer volumio[1260]: info: sendMpdCommand status took 86 milliseconds Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:32 streamer volumio[1260]: info: Command Router : Notfying DB Updatefalse Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::Close All Modals sent Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:32 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:32 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio[1260]: info: No code Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:32 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio[1260]: info: No code Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.780+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.781+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.783+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.783+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.785+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.785+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.787+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.787+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.789+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.789+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.791+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.791+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio[1260]: info: ------------------------------ 179ms Apr 15 15:49:32 streamer volumio[1260]: info: ------------------------------ 180ms Apr 15 15:49:32 streamer volumio[1260]: info: sendMpdCommand status took 230 milliseconds Apr 15 15:49:32 streamer volumio[1260]: info: sendMpdCommand status took 229 milliseconds Apr 15 15:49:32 streamer volumio[1260]: info: sendMpdCommand status took 230 milliseconds Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:32 streamer volumio[1260]: info: Command Router : Notfying DB Updatefalse Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::Close All Modals sent Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:32 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:32 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio[1260]: info: No code Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:32 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio[1260]: info: No code Apr 15 15:49:32 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:32 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.889+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.889+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.891+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.891+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.892+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.892+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.894+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.894+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.896+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.896+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.897+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:32 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:32.898+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:32 streamer volumio[1260]: info: ------------------------------ 289ms Apr 15 15:49:32 streamer volumio[1260]: info: ------------------------------ 289ms Apr 15 15:49:32 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 15:49:32 streamer volumio[1260]: info: sendMpdCommand status took 355 milliseconds Apr 15 15:49:32 streamer volumio[1260]: info: sendMpdCommand status took 353 milliseconds Apr 15 15:49:32 streamer volumio[1260]: info: sendMpdCommand status took 354 milliseconds Apr 15 15:49:32 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:33 streamer volumio[1260]: info: Command Router : Notfying DB Updatefalse Apr 15 15:49:33 streamer volumio[1260]: info: CoreCommandRouter::Close All Modals sent Apr 15 15:49:33 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:33 streamer volumio[1260]: verbose: ControllerMpd::parseState Apr 15 15:49:33 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:33 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:33 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:33 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:33 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:33 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:33 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:33 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:33 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:33 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:33 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:33 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:33 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:33 streamer volumio[1260]: info: No code Apr 15 15:49:33 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:33 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:33 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:33 streamer volumio[1260]: info: ControllerMpd::pushState Apr 15 15:49:33 streamer volumio[1260]: info: CoreCommandRouter::servicePushState Apr 15 15:49:33 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:33 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:33 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:33 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:33 streamer volumio[1260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 15 15:49:33 streamer volumio[1260]: verbose: CURRENT POSITION 0 Apr 15 15:49:33 streamer volumio[1260]: info: CoreStateMachine::syncState stateService stop Apr 15 15:49:33 streamer volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Apr 15 15:49:33 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:33 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:33 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:33 streamer volumio[1260]: info: No code Apr 15 15:49:33 streamer volumio[1260]: info: CoreStateMachine::pushState Apr 15 15:49:33 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:33 streamer volumio[1260]: info: CoreCommandRouter::volumioPushState Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.021+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.021+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.021+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.022+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.023+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.024+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.024+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.025+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.025+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.026+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.027+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 15 15:49:33 streamer volumio5-onboarding[1539]: time=2026-04-15T15:49:33.027+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.168.8:37330 @ 0x2c00bd0" id= title= Apr 15 15:49:33 streamer volumio[1260]: info: ------------------------------ 407ms Apr 15 15:49:33 streamer volumio[1260]: info: ------------------------------ 408ms Apr 15 15:49:36 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 15:49:40 streamer volumio[1260]: info: CoreCommandRouter::volumioGetQueue Apr 15 15:49:40 streamer volumio[1260]: info: CoreStateMachine::getQueue Apr 15 15:49:40 streamer volumio[1260]: info: CorePlayQueue::getQueue Apr 15 15:49:43 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 15 15:49:43 streamer volumio[1260]: info: CURURI: music-library Apr 15 15:49:43 streamer volumio[1260]: info: Preload queue cleared Apr 15 15:49:45 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 15 15:49:45 streamer volumio[1260]: info: CURURI: music-library/USB Apr 15 15:49:45 streamer volumio[1260]: info: Preload queue cleared Apr 15 15:49:46 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 15 15:49:46 streamer volumio[1260]: info: CURURI: music-library/USB/USB_SSD Apr 15 15:49:46 streamer volumio[1260]: info: Preload queue cleared Apr 15 15:49:49 streamer volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 15 15:49:49 streamer volumio[1260]: info: CURURI: music-library/USB/USB_SSD/TEST Apr 15 15:49:49 streamer volumio[1260]: info: Preload queue cleared Apr 15 15:49:49 streamer volumio[1260]: info: Preloading song: music-library/USB/USB_SSD/TEST/Carmine meo.flac Apr 15 15:49:49 streamer volumio[1260]: info: Preloading song: music-library/USB/USB_SSD/TEST/Julio Iglesias - Crazy [1].flac Apr 15 15:49:49 streamer volumio[1260]: info: Preloading song: music-library/USB/USB_SSD/TEST/03. Herb Alpert – Rise (1979) [2].flac Apr 15 15:49:49 streamer volumio[1260]: info: Preloading song: music-library/USB/USB_SSD/TEST/01 - Love You Like A Love Song.flac Apr 15 15:49:49 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Carmine meo.flac in service mpd Apr 15 15:49:49 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Emma%20Shapplin/Carmine%20Meo/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FCarmine%20meo.flac&metadata=false Apr 15 15:49:49 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Carmine meo.flac Apr 15 15:49:49 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Julio Iglesias - Crazy [1].flac in service mpd Apr 15 15:49:49 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Julio%20Iglesias/Crazy/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FJulio%20Iglesias%20-%20Crazy%20%5B1%5D.flac&metadata=false Apr 15 15:49:49 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Julio Iglesias - Crazy [1].flac Apr 15 15:49:49 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/03. Herb Alpert – Rise (1979) [2].flac in service mpd Apr 15 15:49:49 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Herb%20Alpert/Rise/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F03.%20Herb%20Alpert%20%E2%80%93%20Rise%20(1979)%20%5B2%5D.flac&metadata=false Apr 15 15:49:49 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/03. Herb Alpert – Rise (1979) [2].flac Apr 15 15:49:49 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/01 - Love You Like A Love Song.flac in service mpd Apr 15 15:49:49 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Selena%20Gomez%20%26%20The%20Scene/When%20The%20Sun%20Goes%20Down/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F01%20-%20Love%20You%20Like%20A%20Love%20Song.flac&metadata=false Apr 15 15:49:49 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/01 - Love You Like A Love Song.flac Apr 15 15:49:51 streamer volumio[1260]: info: Preload queue cleared Apr 15 15:49:51 streamer volumio[1260]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::ClearQueue Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::stop Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 15:49:51 streamer volumio[1260]: info: CorePlayQueue::clearPlayQueue Apr 15 15:49:51 streamer volumio[1260]: info: CorePlayQueue::saveQueue Apr 15 15:49:51 streamer volumio[1260]: info: CoreCommandRouter::volumioPushQueue Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::addQueueItems Apr 15 15:49:51 streamer volumio[1260]: info: CorePlayQueue::addQueueItems Apr 15 15:49:51 streamer volumio[1260]: info: Preload queue cleared Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Carmine meo.flac Apr 15 15:49:51 streamer volumio[1260]: info: Using cached record of: music-library/USB/USB_SSD/TEST/Carmine meo.flac Apr 15 15:49:51 streamer volumio[1260]: info: CoreCommandRouter::volumioPushQueue Apr 15 15:49:51 streamer volumio[1260]: info: CorePlayQueue::saveQueue Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::updateTrackBlock Apr 15 15:49:51 streamer volumio[1260]: info: CorePlayQueue::getTrackBlock Apr 15 15:49:51 streamer volumio[1260]: info: CoreCommandRouter::volumioPlay Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::play index 0 Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::addQueueItems Apr 15 15:49:51 streamer volumio[1260]: info: CorePlayQueue::addQueueItems Apr 15 15:49:51 streamer volumio[1260]: info: Preload queue cleared Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Julio Iglesias - Crazy [1].flac Apr 15 15:49:51 streamer volumio[1260]: info: Using cached record of: music-library/USB/USB_SSD/TEST/Julio Iglesias - Crazy [1].flac Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/03. Herb Alpert – Rise (1979) [2].flac Apr 15 15:49:51 streamer volumio[1260]: info: Using cached record of: music-library/USB/USB_SSD/TEST/03. Herb Alpert – Rise (1979) [2].flac Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/01 - Love You Like A Love Song.flac Apr 15 15:49:51 streamer volumio[1260]: info: Using cached record of: music-library/USB/USB_SSD/TEST/01 - Love You Like A Love Song.flac Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/24Bit Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/24Bit in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Closer To The Music Vol. 5 Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Closer To The Music Vol. 5 in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Audio Check VA - AYA - Authentic Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Audio Check VA - AYA - Authentic in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Audio Check VA - Sennheiser HD 800 Klang Von Meisterhand (Stockfisch SFR 457.9801.2) (GER 2009) Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Audio Check VA - Sennheiser HD 800 Klang Von Meisterhand (Stockfisch SFR 457.9801.2) (GER 2009) in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Bob James Trio - Fell Like Making LIVE! (2022) Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Bob James Trio - Fell Like Making LIVE! (2022) in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/DSF Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/DSF in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/GoGo Penguin - 2014 - v2.0 Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/GoGo Penguin - 2014 - v2.0 in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Jennifer Warnes - Best- First We Take Manhattan (2000, Zounds) Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Jennifer Warnes - Best- First We Take Manhattan (2000, Zounds) in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Leonard Cohen - Hallelujah & Songs from His Albums - 2022 [FLAC] Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Leonard Cohen - Hallelujah & Songs from His Albums - 2022 [FLAC] in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Lorna Shore (declipped mix) Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Lorna Shore (declipped mix) in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Music From The Batman Trilogy Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Music From The Batman Trilogy in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Norio Maeda - Soul Samba, Holiday in Brazil (1977, 2013, Nippon Crown) Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Norio Maeda - Soul Samba, Holiday in Brazil (1977, 2013, Nippon Crown) in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Orinoco Haven - Acoustic Guitar Pearls Vol. 1-3 [FLAC WEB] Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Orinoco Haven - Acoustic Guitar Pearls Vol. 1-3 [FLAC WEB] in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Polyphia - 2023 - Live at the Factory in Deep Ellum (FLAC) Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Polyphia - 2023 - Live at the Factory in Deep Ellum (FLAC) in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Rage Against the Machine - {1996, Australia} Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Rage Against the Machine - {1996, Australia} in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Rival Sons Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Rival Sons in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/SoundTEST★SoundProLab Absolute 1644 Sampler★ Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/SoundTEST★SoundProLab Absolute 1644 Sampler★ in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/The Sully Band - 2022 - Let's Straighten It Out! [FLAC] Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/The Sully Band - 2022 - Let's Straighten It Out! [FLAC] in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Tsuyoshi Yamamoto Trio - 3 альбома Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Tsuyoshi Yamamoto Trio - 3 альбома in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/WAV Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/WAV in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: Adding Item to queue: music-library/USB/USB_SSD/TEST/Yosi Horikawa - Wandering EP (2012) FLAC-Web Apr 15 15:49:51 streamer volumio[1260]: info: Exploding uri music-library/USB/USB_SSD/TEST/Yosi Horikawa - Wandering EP (2012) FLAC-Web in service mpd Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::stop Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::play index undefined Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 15:49:51 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:51 streamer volumio[1260]: info: CoreStateMachine::startPlaybackTimer Apr 15 15:49:51 streamer volumio[1260]: info: CorePlayQueue::getTrack 0 Apr 15 15:49:51 streamer volumio[1260]: verbose: ControllerMpd::clearAddPlayTracks USB/USB_SSD/TEST/Carmine meo.flac Apr 15 15:49:51 streamer volumio[1260]: verbose: ControllerMpd::sendMpdCommand stop Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=%D0%9B%D0%B8%D0%BD%D0%B4%D0%B0/%D0%9F%D0%B5%D1%81%D0%BD%D0%B8%20%D1%82%D0%B8%D0%B1%D0%B5%D1%82%D1%81%D0%BA%D0%B8%D1%85%20%D0%BB%D0%B0%D0%BC/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FA3.%20%D0%9F%D0%B5%D1%81%D0%BD%D0%B8%20%D1%82%D0%B8%D0%B1%D0%B5%D1%82%D1%81%D0%BA%D0%B8%D1%85%20%D0%BB%D0%B0%D0%BC.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/A3. Песни тибетских лам.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Faith%20No%20More/The%20Real%20Thing%20(2015%20UK%20Reissue)/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FFaith%20No%20More%20-%201989%20-%20The%20Real%20Thing%20%5BPBTHAL%202025%5D%20(2015%20UK%20Reissue)%2F14%20-%20War%20Pigs%20(Live%20In%20Berlin).flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/Faith No More - 1989 - The Real Thing [PBTHAL 2025] (2015 UK Reissue)/14 - War Pigs (Live In Berlin).flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Nick%20Cave%20%26%20The%20Bad%20Seeds/Live%20in%20Wilters%20Theatre.%20Los%20Angeles.%2017.04.2002/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FRed%20Right%20Hand.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/Red Right Hand.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Rodrigo%20y%20Gabriela/11%3A11%20%20(180%20LP)/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FRodrigo%20%26%20Gabriela%20%E2%80%93%2011-11%20(2009)%20(2014%20ATO%20Records%20LP)%2024-96%2F01%20Hanuman.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/Rodrigo & Gabriela – 11-11 (2009) (2014 ATO Records LP) 24-96/01 Hanuman.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Bassface%20Swing%20Trio%20feat.%20Bruno%20M%C3%BCller/Bossa%2C%20Ballads%20and%20Blues/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FThe%20Bassface%20Swing%20Trio%202022%20Bossa%2C%20Ballads%20and%20Blues%20(feat.%20Bruno%20M%C3%BCller)%20WEB%20Stockfisch%20Records%20SFR357.2101.0%20%5BHi-Res%2024bit-88.2kHz%5D%2F01.%20Estate.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/The Bassface Swing Trio 2022 Bossa, Ballads and Blues (feat. Bruno Müller) WEB Stockfisch Records SFR357.2101.0 [Hi-Res 24bit-88.2kHz]/01. Estate.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Bassface%20Swing%20Trio%20feat.%20Bruno%20M%C3%BCller/Bossa%2C%20Ballads%20and%20Blues/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FThe%20Bassface%20Swing%20Trio%202022%20Bossa%2C%20Ballads%20and%20Blues%20(feat.%20Bruno%20M%C3%BCller)%20WEB%20Stockfisch%20Records%20SFR357.2101.0%20%5BHi-Res%2024bit-88.2kHz%5D%2F02.%20Prelude%20to%20a%20Kiss.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/The Bassface Swing Trio 2022 Bossa, Ballads and Blues (feat. Bruno Müller) WEB Stockfisch Records SFR357.2101.0 [Hi-Res 24bit-88.2kHz]/02. Prelude to a Kiss.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Bassface%20Swing%20Trio%20feat.%20Bruno%20M%C3%BCller/Bossa%2C%20Ballads%20and%20Blues/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FThe%20Bassface%20Swing%20Trio%202022%20Bossa%2C%20Ballads%20and%20Blues%20(feat.%20Bruno%20M%C3%BCller)%20WEB%20Stockfisch%20Records%20SFR357.2101.0%20%5BHi-Res%2024bit-88.2kHz%5D%2F03.%20Georgia%20on%20My%20Mind.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/The Bassface Swing Trio 2022 Bossa, Ballads and Blues (feat. Bruno Müller) WEB Stockfisch Records SFR357.2101.0 [Hi-Res 24bit-88.2kHz]/03. Georgia on My Mind.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Bassface%20Swing%20Trio%20feat.%20Bruno%20M%C3%BCller/Bossa%2C%20Ballads%20and%20Blues/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FThe%20Bassface%20Swing%20Trio%202022%20Bossa%2C%20Ballads%20and%20Blues%20(feat.%20Bruno%20M%C3%BCller)%20WEB%20Stockfisch%20Records%20SFR357.2101.0%20%5BHi-Res%2024bit-88.2kHz%5D%2F04.%20Stardust.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/The Bassface Swing Trio 2022 Bossa, Ballads and Blues (feat. Bruno Müller) WEB Stockfisch Records SFR357.2101.0 [Hi-Res 24bit-88.2kHz]/04. Stardust.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Bassface%20Swing%20Trio%20feat.%20Bruno%20M%C3%BCller/Bossa%2C%20Ballads%20and%20Blues/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FThe%20Bassface%20Swing%20Trio%202022%20Bossa%2C%20Ballads%20and%20Blues%20(feat.%20Bruno%20M%C3%BCller)%20WEB%20Stockfisch%20Records%20SFR357.2101.0%20%5BHi-Res%2024bit-88.2kHz%5D%2F05.%20Black%20Coffee.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/The Bassface Swing Trio 2022 Bossa, Ballads and Blues (feat. Bruno Müller) WEB Stockfisch Records SFR357.2101.0 [Hi-Res 24bit-88.2kHz]/05. Black Coffee.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Bassface%20Swing%20Trio%20feat.%20Bruno%20M%C3%BCller/Bossa%2C%20Ballads%20and%20Blues/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FThe%20Bassface%20Swing%20Trio%202022%20Bossa%2C%20Ballads%20and%20Blues%20(feat.%20Bruno%20M%C3%BCller)%20WEB%20Stockfisch%20Records%20SFR357.2101.0%20%5BHi-Res%2024bit-88.2kHz%5D%2F06.%20The%20Shadow%20of%20Your%20Smile.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/The Bassface Swing Trio 2022 Bossa, Ballads and Blues (feat. Bruno Müller) WEB Stockfisch Records SFR357.2101.0 [Hi-Res 24bit-88.2kHz]/06. The Shadow of Your Smile.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Bassface%20Swing%20Trio%20feat.%20Bruno%20M%C3%BCller/Bossa%2C%20Ballads%20and%20Blues/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FThe%20Bassface%20Swing%20Trio%202022%20Bossa%2C%20Ballads%20and%20Blues%20(feat.%20Bruno%20M%C3%BCller)%20WEB%20Stockfisch%20Records%20SFR357.2101.0%20%5BHi-Res%2024bit-88.2kHz%5D%2F07.%20Laura.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/The Bassface Swing Trio 2022 Bossa, Ballads and Blues (feat. Bruno Müller) WEB Stockfisch Records SFR357.2101.0 [Hi-Res 24bit-88.2kHz]/07. Laura.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Bassface%20Swing%20Trio%20feat.%20Bruno%20M%C3%BCller/Bossa%2C%20Ballads%20and%20Blues/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2F24Bit%2FThe%20Bassface%20Swing%20Trio%202022%20Bossa%2C%20Ballads%20and%20Blues%20(feat.%20Bruno%20M%C3%BCller)%20WEB%20Stockfisch%20Records%20SFR357.2101.0%20%5BHi-Res%2024bit-88.2kHz%5D%2F08.%20I%20Can't%20Get%20Started.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/24Bit/The Bassface Swing Trio 2022 Bossa, Ballads and Blues (feat. Bruno Müller) WEB Stockfisch Records SFR357.2101.0 [Hi-Res 24bit-88.2kHz]/08. I Can't Get Started.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Allan%20Taylor/Audiophile%20recordings%20Volume%201/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%201%2F01%20Colour%20To%20The%20Moon.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 1/01 Colour To The Moon.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Allan%20Taylor/Audiophile%20recordings%20Volume%201/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%201%2F02%20A%20House%20By%20The%20River.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 1/02 A House By The River.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Steve%20Strauss/Audiophile%20recordings%20Volume%201/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%201%2F03%20Jennie%20Mae.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 1/03 Jennie Mae.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Cristian%20Willisohn/Audiophile%20recordings%20Volume%201/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%201%2F04%20Hold%20On%20I'm%20Waiting%20For%20You.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 1/04 Hold On I'm Waiting For You.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Cristian%20Willisohn/Audiophile%20recordings%20Volume%201/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%201%2F05%20Lestat's%20Lamento.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 1/05 Lestat's Lamento.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Naoki%20Kitaya/Audiophile%20recordings%20Volume%201/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%201%2F06%20L.%20Couperin-%20Tombeau%20de%20Mr.%20de%20Blancrocher.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 1/06 L. Couperin- Tombeau de Mr. de Blancrocher.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Kurpf%C3%A4lzisches%20Kammerorchester%20Mannheim/Audiophile%20recordings%20Volume%201/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%201%2F07%20D.%20Schostakowitsch-%20Allegretto%20fur%20Streichquartett.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 1/07 D. Schostakowitsch- Allegretto fur Streichquartett.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Steve%20Strauss/INFINITY%20Audiophile%20Recordings%20-%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%202%2F01%20Argyle%20Bridge.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 2/01 Argyle Bridge.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=David%20Munyon/INFINITY%20Audiophile%20Recordings%20-%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%202%2F02%20Guitar%20Road.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 2/02 Guitar Road.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Chris%20Jones/INFINITY%20Audiophile%20Recordings%20-%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%202%2F03%20Would%20Not%20Have%20It%20Any%20Other%20Way.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 2/03 Would Not Have It Any Other Way.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Werner%20L%C3%A4mmerhirt/INFINITY%20Audiophile%20Recordings%20-%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%202%2F04%20Kirmes.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 2/04 Kirmes.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Allan%20Taylor/INFINITY%20Audiophile%20Recordings%20-%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%202%2F05%20Cold%20Hard%20Town.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 2/05 Cold Hard Town.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=David%20Munyon/INFINITY%20Audiophile%20Recordings%20-%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%202%2F06%20N.Y.C..flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 2/06 N.Y.C..flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Duo%20Balance/INFINITY%20Audiophile%20Recordings%20-%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%202%2F07%20Morning%20Of%20My%20Life.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 2/07 Morning Of My Life.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Allan%20Taylor/stereoplay%20Highlights%202001/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%203%2F01%20Wheel%20Of%20Fortune.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 3/01 Wheel Of Fortune.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Paul%20Stephenson/stereoplay%20Highlights%202001/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%203%2F02%20Light%20Green%20Ball.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 3/02 Light Green Ball.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Steve%20Strauss/stereoplay%20Highlights%202001/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%203%2F03%20Two%20By%20Two.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 3/03 Two By Two.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Peter%20Ratzenbeck/stereoplay%20Highlights%202001/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%203%2F04%20Fraunz%20Bodschengls.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 3/04 Fraunz Bodschengls.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=David%20Munyon/stereoplay%20Highlights%202001/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%203%2F05%20Save%20The%20Whales%20In%20Placerville%20And%20Hickston.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 3/05 Save The Whales In Placerville And Hickston.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Spirit%20Of%20Gambo%3A%20John%20Cooper/stereoplay%20Highlights%202001/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%203%2F06%20Fantasia%20A%204.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 3/06 Fantasia A 4.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Spirit%20Of%20Gambo%3A%20John%20Cooper/stereoplay%20Highlights%202001/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%203%2F07%20Fantasia%20A%203.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 3/07 Fantasia A 3.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Spirit%20Of%20Gambo%3A%20Pierre%20Sandrin%20%26%20Diego%20Ortiz/stereoplay%20Highlights%202001/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%203%2F08%20Doulce%20Memoire.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 3/08 Doulce Memoire.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Spirit%20Of%20Gambo%3A%20Cornelis%20Thymanszn%20Padbru%C3%A9/stereoplay%20Highlights%202001/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%203%2F09%20Pavana.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 3/09 Pavana.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=The%20Spirit%20Of%20Gambo%3A%20Cornelis%20Thymanszn%20Padbru%C3%A9/stereoplay%20Highlights%202001/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Audiophile%20Recordings%2FVarious%20-%20Audiophile%20Recordings%20Volume%203%2F10%20Galliarda.flac&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Audiophile Recordings/Various - Audiophile Recordings Volume 3/10 Galliarda.flac Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Allan%20Taylor/closer%20to%20the%20music%20Vol.5/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Closer%20To%20The%20Music%20Vol.%205%2FVarious%20Artists%20-%20closer%20to%20the%20music%20Vol.5.cue&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Closer To The Music Vol. 5/Various Artists - closer to the music Vol.5.cue Apr 15 15:49:51 streamer volumio[1260]: info: ALBUMART /albumart?cacheid=544&web=Steve%20Strauss/closer%20to%20the%20music%20Vol.5/extralarge&path=%2Fmnt%2FUSB%2FUSB_SSD%2FTEST%2FAudio%20Check%20Stockfisch%20Records%20-%20Closer%20To%20The%20Music%20Vol.%205%2FVarious%20Artists%20-%20closer%20to%20the%20music%20Vol.5.cue&metadata=false Apr 15 15:49:51 streamer volumio[1260]: info: URI /mnt/USB/USB_SSD/TEST/Audio Check Stockfisch Records - Closer To The Music Vol. 5/Various Artists - closer to the music Vol.5.cue Apr 15 15:49:51 streamer volumio[1260]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 15:49:51 streamer volumio[1260]: Error: Unable to resolve or reject the same promise twice Apr 15 15:49:51 streamer volumio[1260]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 15 15:49:51 streamer volumio[1260]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Apr 15 15:49:51 streamer volumio[1260]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 15 15:49:51 streamer volumio[1260]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 15 15:49:51 streamer volumio[1260]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 15 15:49:51 streamer volumio[1260]: at Socket.emit (node:events:514:28) Apr 15 15:49:51 streamer volumio[1260]: at addChunk (node:internal/streams/readable:343:12) Apr 15 15:49:51 streamer volumio[1260]: at readableAddChunk (node:internal/streams/readable:312:11) Apr 15 15:49:51 streamer volumio[1260]: at Readable.push (node:internal/streams/readable:253:10) Apr 15 15:49:51 streamer volumio[1260]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Apr 15 15:49:51 streamer volumio[1260]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 15:49:52 streamer sudo[2424]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-15 15:48' Apr 15 15:49:52 streamer sudo[2424]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"