-- Logs begin at Thu 2019-02-14 05:11:59 -05, end at Thu 2025-04-24 15:02:55 -05. -- Apr 24 15:01:02 zero volumio-remote-updater[495]: [2025-04-24 15:01:02] [connect] Successful connection Apr 24 15:01:05 zero volumio[851]: info: Loading plugin "ytmusic"... Apr 24 15:01:10 zero volumio[851]: info: Loading plugin "outputs"... Apr 24 15:01:10 zero volumio[851]: info: Loading plugin "albumart"... Apr 24 15:01:10 zero volumio[851]: info: Plugin example_plugin is not enabled Apr 24 15:01:10 zero volumio[851]: info: Loading plugin "inputs"... Apr 24 15:01:10 zero volumio[851]: info: Loading plugin "updater_comm"... Apr 24 15:01:10 zero volumio[851]: info: Plugin mpdemulation is not enabled Apr 24 15:01:10 zero volumio[851]: info: Loading plugin "rest_api"... Apr 24 15:01:10 zero volumio[851]: info: Loading plugin "websocket"... Apr 24 15:01:10 zero volumio[851]: info: Starting Socket.io Server version 2.3.0 Apr 24 15:01:10 zero volumio[851]: info: Loading plugin "fusiondsp"... Apr 24 15:01:10 zero volumio[851]: Forking 3 albumart workers Apr 24 15:01:11 zero volumio[851]: info: Applying required configuration parameters for plugin fusiondsp Apr 24 15:01:11 zero volumio[851]: info: Loading plugin "80s80s"... Apr 24 15:01:12 zero volumio[851]: info: Applying required configuration parameters for plugin 80s80s Apr 24 15:01:12 zero volumio[851]: info: [1745524872360] [80s80s] API delay: 30 Apr 24 15:01:12 zero volumio[851]: Starting albumart workers Apr 24 15:01:12 zero volumio[851]: Starting albumart workers Apr 24 15:01:12 zero volumio[851]: Starting albumart workers Apr 24 15:01:12 zero volumio[851]: info: Loading i18n strings for locale es Apr 24 15:01:12 zero volumio[851]: Updating browse sources language Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::initPlayerControls Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:12 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 15:01:12 zero volumio[851]: Express server listening on port 3000 Apr 24 15:01:12 zero volumio[851]: [Metrics] WebUI: 30s 336.38ms Apr 24 15:01:13 zero volumio[851]: info: CoreStateMachine::resetVolumioState Apr 24 15:01:13 zero volumio[851]: info: CoreStateMachine::getcurrentVolume Apr 24 15:01:13 zero volumio[851]: info: CoreCommandRouter::volumioRetrievevolume Apr 24 15:01:13 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:13 zero volumio[851]: info: Volumio Network Manager: Network status updated: 2 Apr 24 15:01:13 zero volumio[851]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 1 Apr 24 15:01:13 zero sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 24 15:01:13 zero sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:13 zero sudo[1047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 15:01:13 zero sudo[1047]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:13 zero volumio[851]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 2 Apr 24 15:01:13 zero sudo[1047]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:13 zero volumio[851]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 3 Apr 24 15:01:13 zero volumio[851]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 4 Apr 24 15:01:13 zero volumio[851]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 5 Apr 24 15:01:13 zero volumio[851]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 6 Apr 24 15:01:13 zero sudo[1045]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:13 zero volumio[851]: info: Reloading queue from file Apr 24 15:01:13 zero volumio[851]: info: CoreStateMachine::setRepeat false single undefined Apr 24 15:01:13 zero volumio[851]: info: CoreStateMachine::pushState Apr 24 15:01:13 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:13 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 15:01:13 zero volumio[851]: info: CoreCommandRouter::volumioPushState Apr 24 15:01:13 zero volumio[851]: info: CoreStateMachine::setRandom true Apr 24 15:01:13 zero volumio[851]: info: CoreStateMachine::pushState Apr 24 15:01:13 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:13 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 15:01:13 zero volumio[851]: info: CoreCommandRouter::volumioPushState Apr 24 15:01:13 zero volumio[851]: info: VolumeController:: Volume=64 Mute =false Apr 24 15:01:13 zero volumio[851]: info: CoreStateMachine::pushState Apr 24 15:01:13 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:13 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 15:01:13 zero volumio[851]: info: CoreCommandRouter::volumioPushState Apr 24 15:01:13 zero volumio[851]: info: CoreStateMachine::updateTrackBlock Apr 24 15:01:13 zero volumio[851]: info: CorePlayQueue::getTrackBlock Apr 24 15:01:13 zero volumio[851]: info: CoreCommandRouter::volumioRetrievevolume Apr 24 15:01:13 zero volumio[851]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Apr 24 15:01:13 zero volumio[851]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Apr 24 15:01:13 zero volumio[851]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Apr 24 15:01:13 zero volumio[851]: info: Setting Device type: Raspberry PI Apr 24 15:01:14 zero sudo[1084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 24 15:01:14 zero sudo[1084]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:14 zero volumio[851]: info: Discovery: adding 9f8d5a4a-6806-46fe-b062-8e8decea0002 Apr 24 15:01:14 zero volumio[851]: info: Discovery: Found device Zero Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:14 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:14 zero volumio[851]: info: Completed loading Core Plugins Apr 24 15:01:14 zero volumio[851]: info: Preparing to generate the ALSA configuration file Apr 24 15:01:14 zero systemd[1]: Started UPnP Renderer front-end to MPD. Apr 24 15:01:14 zero volumio[851]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 24 15:01:14 zero volumio[851]: info: Reading ALSA contributions from plugins. Apr 24 15:01:14 zero sudo[1084]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:14 zero volumio[851]: info: VolumeController:: Volume=64 Mute =false Apr 24 15:01:14 zero volumio[851]: info: CoreStateMachine::pushState Apr 24 15:01:14 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::volumioPushState Apr 24 15:01:14 zero volumio[851]: info: Upmpdcli Daemon Started Apr 24 15:01:14 zero volumio[851]: info: Asound.conf file unchanged, so no further update is needed Apr 24 15:01:14 zero volumio[851]: info: Output device has changed, restarting MPD Apr 24 15:01:14 zero sudo[1089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 24 15:01:14 zero sudo[1089]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:14 zero sudo[1089]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:14 zero volumio[851]: info: Output device has changed, restarting Shairport Sync Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:14 zero sudo[1092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 24 15:01:14 zero sudo[1092]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:14 zero systemd[1]: Stopping Music Player Daemon... Apr 24 15:01:14 zero volumio[851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 15:01:14 zero volumio[851]: info: ___________ START PLUGINS ___________ Apr 24 15:01:14 zero volumio[851]: info: ControllerMpd::onStart: Initializing MPD Apr 24 15:01:14 zero volumio[851]: info: Creating MPD Configuration file Apr 24 15:01:14 zero sudo[1098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 24 15:01:14 zero sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:01:14 zero volumio[851]: info: [1745524874474] CoreMusicLibrary::Adding element Media Servers Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:01:14 zero sudo[1098]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:14 zero sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 24 15:01:14 zero sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:14 zero volumio[851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:14 zero volumio[851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:01:14 zero volumio[851]: info: [1745524874679] CoreMusicLibrary::Adding element Last_100 Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:01:14 zero volumio[851]: info: [1745524874684] CoreMusicLibrary::Adding element Webradio Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 24 15:01:14 zero volumio[851]: info: Initializing BBC Radios Apr 24 15:01:14 zero volumio[851]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:14 zero volumio[851]: info: Adding Calm Radio to Browse Sources Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:01:14 zero volumio[851]: info: [1745524874886] CoreMusicLibrary::Adding element Calm Radio Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:01:14 zero volumio[851]: Cannot find translation for source Calm Radio Apr 24 15:01:14 zero volumio[851]: info: Creating Spotify config file Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:01:14 zero volumio[851]: info: [1745524874950] CoreMusicLibrary::Adding element YouTube2 Apr 24 15:01:14 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:01:14 zero volumio[851]: Cannot find translation for source Calm Radio Apr 24 15:01:14 zero volumio[851]: Cannot find translation for source YouTube2 Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:01:15 zero volumio[851]: info: [1745524875033] CoreMusicLibrary::Adding element YouTube Music Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:01:15 zero volumio[851]: Cannot find translation for source Calm Radio Apr 24 15:01:15 zero volumio[851]: Cannot find translation for source YouTube2 Apr 24 15:01:15 zero volumio[851]: Cannot find translation for source YouTube Music Apr 24 15:01:15 zero volumio[851]: info: Loading i18n strings for locale es Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: FusionDsp - mixtype--------------------- Hardware Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:01:15 zero volumio[851]: info: [1745524875081] CoreMusicLibrary::Adding element 80s80s Radio Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:01:15 zero volumio[851]: Cannot find translation for source Calm Radio Apr 24 15:01:15 zero volumio[851]: Cannot find translation for source YouTube2 Apr 24 15:01:15 zero volumio[851]: Cannot find translation for source YouTube Music Apr 24 15:01:15 zero volumio[851]: Cannot find translation for source 80s80s Radio Apr 24 15:01:15 zero volumio[851]: info: Volumio Calling Home Apr 24 15:01:15 zero volumio[851]: info: Preparing to generate the ALSA configuration file Apr 24 15:01:15 zero volumio[851]: verbose: [yt-cast-receiver] Setting app pid to stored value: 0790e94f-2a47-4c4e-8911-b2505d7af98b Apr 24 15:01:15 zero volumio[851]: verbose: [yt-cast-receiver] Starting YouTubeApp... Apr 24 15:01:15 zero volumio[851]: verbose: [yt-cast-receiver] (YouTube) Configuring session with stored MDX context: Apr 24 15:01:15 zero volumio[851]: { Apr 24 15:01:15 zero volumio[851]: deviceId: 'b09c8eaa-61a9-47d1-8655-fee1bad2fba5', Apr 24 15:01:15 zero volumio[851]: screenId: '79t767efofk6v1tep43qs0h93s' Apr 24 15:01:15 zero volumio[851]: } Apr 24 15:01:15 zero volumio[851]: verbose: [yt-cast-receiver] (YouTube Music) Configuring session with stored MDX context: Apr 24 15:01:15 zero volumio[851]: { Apr 24 15:01:15 zero volumio[851]: deviceId: 'd23b40c7-a779-4ac5-8fa3-143b46148b7c', Apr 24 15:01:15 zero volumio[851]: screenId: 'qbs9eq2sphvv2o0lhh0c2f1dpp' Apr 24 15:01:15 zero volumio[851]: } Apr 24 15:01:15 zero volumio[851]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 24 15:01:15 zero volumio[851]: info: Reading ALSA contributions from plugins. Apr 24 15:01:15 zero systemd[1]: mpd.service: Succeeded. Apr 24 15:01:15 zero systemd[1]: Stopped Music Player Daemon. Apr 24 15:01:15 zero volumio[851]: info: MPD Permissions set Apr 24 15:01:15 zero volumio[851]: info: MPD Permissions set Apr 24 15:01:15 zero volumio[851]: info: Spotify config file written Apr 24 15:01:15 zero systemd[1]: Starting Music Player Daemon... Apr 24 15:01:15 zero volumio[851]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 24 15:01:15 zero sudo[1124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 24 15:01:15 zero sudo[1124]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:15 zero volumio[851]: info: Volumio called home Apr 24 15:01:15 zero volumio[851]: info: No need to fix Spotify hosts Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero sudo[1122]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 24 15:01:15 zero sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:15 zero systemd[1]: Started go-librespot Daemon. Apr 24 15:01:15 zero sudo[1122]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Apr 24 15:01:15 zero sudo[1122]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:15 zero go-librespot[1127]: go-librespot daemon starting... Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero sudo[1124]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:15 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:16 zero systemd[1]: systemd-timedated.service: Succeeded. Apr 24 15:01:16 zero volumio[851]: info: Starting Shairport Sync Apr 24 15:01:16 zero volumio[851]: info: Starting Shairport Sync Apr 24 15:01:16 zero volumio[851]: info: Starting Shairport Sync Apr 24 15:01:16 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:16 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:16 zero go-librespot[1127]: time="2025-04-24T15:01:16-05:00" level=info msg="running go-librespot 0.2.0" Apr 24 15:01:16 zero go-librespot[1127]: time="2025-04-24T15:01:16-05:00" level=debug msg="app state loaded" Apr 24 15:01:16 zero go-librespot[1127]: time="2025-04-24T15:01:16-05:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 24 15:01:16 zero sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 24 15:01:16 zero sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:16 zero sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 24 15:01:16 zero sudo[1150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 24 15:01:16 zero sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:16 zero sudo[1150]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:16 zero volumio[851]: info: Asound.conf file unchanged, so no further update is needed Apr 24 15:01:16 zero volumio[851]: info: Output device has changed, restarting MPD Apr 24 15:01:16 zero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 24 15:01:16 zero systemd[1]: shairport-sync.service: Succeeded. Apr 24 15:01:16 zero systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 24 15:01:16 zero sudo[1157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 24 15:01:16 zero sudo[1157]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:16 zero volumio[851]: info: Output device has changed, restarting Shairport Sync Apr 24 15:01:16 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:16 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:16 zero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 24 15:01:16 zero sudo[1146]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:16 zero sudo[1160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 24 15:01:16 zero sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:16 zero sudo[1148]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:16 zero sudo[1150]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:16 zero sudo[1157]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:16 zero systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 24 15:01:16 zero systemd[1]: mpd.service: Succeeded. Apr 24 15:01:16 zero systemd[1]: Stopped Music Player Daemon. Apr 24 15:01:16 zero volumio[851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 15:01:16 zero systemd[1]: Starting Music Player Daemon... Apr 24 15:01:16 zero volumio[851]: info: MPD Permissions set Apr 24 15:01:16 zero volumio[851]: info: Shairport-Sync Started Apr 24 15:01:16 zero volumio[851]: Error adding Membership: Error: addMembership EINVAL Apr 24 15:01:16 zero volumio[851]: info: Shairport-Sync Started Apr 24 15:01:16 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:17 zero sudo[1165]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 24 15:01:17 zero sudo[1165]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:17 zero sudo[1165]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Apr 24 15:01:17 zero sudo[1165]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:17 zero volumio-remote-updater[495]: [2025-04-24 15:01:17] [connect] Successful connection Apr 24 15:01:17 zero volumio[851]: info: camilladsp spawned new process with pid 1180, instance 1, run: true Apr 24 15:01:17 zero volumio[851]: info: camilladsp service started and running in background, instance 1 Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:17 zero go-librespot[1127]: time="2025-04-24T15:01:17-05:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 24 15:01:17 zero go-librespot[1127]: time="2025-04-24T15:01:17-05:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 24 15:01:17 zero go-librespot[1127]: time="2025-04-24T15:01:17-05:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 24 15:01:17 zero go-librespot[1127]: time="2025-04-24T15:01:17-05:00" level=info msg="zeroconf server listening on port 45493" Apr 24 15:01:17 zero volumio[851]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 <-AAAAAAAAAAAAA Apr 24 15:01:17 zero volumio[851]: info: FusionDsp loaded Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 24 15:01:17 zero volumio[851]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 24 15:01:17 zero volumio[851]: info: Adding Signal Path Element [object Object] Apr 24 15:01:17 zero volumio[851]: info: Adding fusiondspeq DSP Signal Path Element Apr 24 15:01:17 zero volumio[851]: info: FusionDsp - ---- installed callbackRead Apr 24 15:01:17 zero volumio[851]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 24 15:01:17 zero sudo[1190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 24 15:01:17 zero sudo[1190]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:17 zero volumio[851]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 8 Apr 24 15:01:17 zero volumio[851]: verbose: [yt-cast-receiver] (YouTube Music) Obtained lounge token: Apr 24 15:01:17 zero volumio[851]: { Apr 24 15:01:17 zero volumio[851]: screenId: 'qbs9eq2sphvv2o0lhh0c2f1dpp', Apr 24 15:01:17 zero volumio[851]: refreshIntervalInMillis: 1123200000, Apr 24 15:01:17 zero volumio[851]: remoteRefreshIntervalMs: 79200000, Apr 24 15:01:17 zero volumio[851]: refreshIntervalMs: 1123200000, Apr 24 15:01:17 zero volumio[851]: loungeTokenLifespanMs: 1209600000, Apr 24 15:01:17 zero volumio[851]: loungeToken: 'AGdO5p_qAJ4C8OozYH-g4Lx2s-FrABkcWFxtGEXl3h7Ovgxlehbswc5uiXEZx7QDFB2_mAcBpij-ouVzKHXDiHViqZ7w6NjGpnCZFsyQcfUxKjiWjsjbxDs', Apr 24 15:01:17 zero volumio[851]: remoteRefreshIntervalInMillis: 79200000, Apr 24 15:01:17 zero volumio[851]: expiration: 1746648077088 Apr 24 15:01:17 zero volumio[851]: } Apr 24 15:01:17 zero volumio-remote-updater[495]: [2025-04-24 15:01:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745524877 101 Apr 24 15:01:17 zero volumio[851]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 9 Apr 24 15:01:17 zero volumio[851]: info: Starting Shairport Sync Apr 24 15:01:17 zero systemd[1]: Started FusionDsp Daemon. Apr 24 15:01:17 zero sudo[1190]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:17 zero volumio[851]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Apr 24 15:01:17 zero sudo[1196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 24 15:01:17 zero volumio[851]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 24 15:01:17 zero sudo[1196]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 24 15:01:17 zero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 24 15:01:17 zero systemd[1]: shairport-sync.service: Succeeded. Apr 24 15:01:17 zero systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::volumioGetVisibleSources Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:17 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:17 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 24 15:01:17 zero volumio[851]: info: Received Get System Info Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 24 15:01:17 zero volumio[851]: info: Discovery: Getting this device information Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:17 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 24 15:01:17 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:17 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:17 zero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 24 15:01:18 zero sudo[1196]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:18 zero volumio[851]: info: Listing playlists Apr 24 15:01:18 zero volumio[851]: info: CoreCommandRouter::volumioGetQueue Apr 24 15:01:18 zero volumio[851]: info: CoreStateMachine::getQueue Apr 24 15:01:18 zero volumio[851]: info: CorePlayQueue::getQueue Apr 24 15:01:18 zero volumio[851]: info: Shairport-Sync Started Apr 24 15:01:18 zero volumio[851]: verbose: [yt-cast-receiver] (YouTube) Obtained lounge token: Apr 24 15:01:18 zero volumio[851]: { Apr 24 15:01:18 zero volumio[851]: screenId: '79t767efofk6v1tep43qs0h93s', Apr 24 15:01:18 zero volumio[851]: refreshIntervalInMillis: 1123200000, Apr 24 15:01:18 zero volumio[851]: remoteRefreshIntervalMs: 79200000, Apr 24 15:01:18 zero volumio[851]: refreshIntervalMs: 1123200000, Apr 24 15:01:18 zero volumio[851]: loungeTokenLifespanMs: 1209600000, Apr 24 15:01:18 zero volumio[851]: loungeToken: 'AGdO5p_ErV6g0eyUnb-snPsKk_Yogj9leBkpVMXi33ONLq9evov2BJn07VUTc0yh-zCpJhd-zlNU6UZkt4AJRiZdKCD0u2LZtVjEa27RH6_BSOk7eKwH7K4', Apr 24 15:01:18 zero volumio[851]: remoteRefreshIntervalInMillis: 79200000, Apr 24 15:01:18 zero volumio[851]: expiration: 1746648077120 Apr 24 15:01:18 zero volumio[851]: } Apr 24 15:01:18 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:18 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:18 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:18 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:18 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:18 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:18 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:18 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:18 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:21 zero mpd[1175]: Apr 24 15:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 24 15:01:21 zero systemd[1]: Started Music Player Daemon. Apr 24 15:01:21 zero sudo[1100]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:21 zero sudo[1092]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:21 zero sudo[1160]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:22 zero volumio[851]: info: go-librespot daemon successfully initialized Apr 24 15:01:22 zero volumio[851]: Upnp client error: Error: This socket has been ended by the other party Apr 24 15:01:24 zero volumio[851]: Upnp client error: Error: This socket has been ended by the other party Apr 24 15:01:24 zero volumio[851]: error: MPD error: The expression evaluated to a falsy value: Apr 24 15:01:24 zero volumio[851]: assert.ok(self.idling) Apr 24 15:01:24 zero volumio[851]: error: The expression evaluated to a falsy value: Apr 24 15:01:24 zero volumio[851]: assert.ok(self.idling) Apr 24 15:01:24 zero volumio[851]: error: MPD error: The expression evaluated to a falsy value: Apr 24 15:01:24 zero volumio[851]: assert.ok(self.idling) Apr 24 15:01:24 zero volumio[851]: error: The expression evaluated to a falsy value: Apr 24 15:01:24 zero volumio[851]: assert.ok(self.idling) Apr 24 15:01:24 zero volumio[851]: info: MPD running with PID1175 Apr 24 15:01:24 zero volumio[851]: ,establishing connection Apr 24 15:01:24 zero volumio[851]: error: updateQueue error: null Apr 24 15:01:24 zero volumio[851]: error: updateQueue error: null Apr 24 15:01:24 zero volumio[851]: verbose: [yt-cast-receiver] (YouTube Music) Received messages for establishing session: Apr 24 15:01:24 zero volumio[851]: [ Apr 24 15:01:24 zero volumio[851]: Message { AID: 0, name: 'c', payload: [ '82EE9E0180093168', '', 8 ] }, Apr 24 15:01:24 zero volumio[851]: Message { Apr 24 15:01:24 zero volumio[851]: AID: 1, Apr 24 15:01:24 zero volumio[851]: name: 'S', Apr 24 15:01:24 zero volumio[851]: payload: 'lEqSoznOrTmDUQUTvNLZqRYBcWK117sWeL2CeYQoabA' Apr 24 15:01:24 zero volumio[851]: }, Apr 24 15:01:24 zero volumio[851]: Message { Apr 24 15:01:24 zero volumio[851]: AID: 2, Apr 24 15:01:24 zero volumio[851]: name: 'loungeStatus', Apr 24 15:01:24 zero volumio[851]: payload: { Apr 24 15:01:24 zero volumio[851]: queueId: 'RQXxWmWdT3hSYcXUO_KEcsVq8KNII', Apr 24 15:01:24 zero volumio[851]: devices: '[{"app":"ytcr","capabilities":"dsp,mic,dpa,ntb","clientName":"unknown","experiments":"","name":"YouTube on Zero","theme":"m","id":"d23b40c7-a779-4ac5-8fa3-143b46148b7c","type":"LOUNGE_SCREEN","hasCc":"true","deviceInfo":"{\\"year\\":0,\\"os\\":\\"Windows\\",\\"osVersion\\":\\"10.0\\",\\"chipset\\":\\"\\",\\"clientName\\":\\"TVHTML5\\",\\"dialAdditionalDataSupportLevel\\":\\"unsupported\\",\\"mdxDialServerType\\":\\"MDX_DIAL_SERVER_TYPE_UNKNOWN\\",\\"brand\\":\\"Generic\\",\\"model\\":\\"SmartTV\\"}","receiverIdentityMatchStatus":"IS_RECEIVER"}]', Apr 24 15:01:24 zero volumio[851]: connectionEventDetails: '{"deviceId":"d23b40c7-a779-4ac5-8fa3-143b46148b7c"}' Apr 24 15:01:24 zero volumio[851]: } Apr 24 15:01:24 zero volumio[851]: }, Apr 24 15:01:24 zero volumio[851]: Message { AID: 3, name: 'getNowPlaying', payload: {} }, Apr 24 15:01:24 zero volumio[851]: Message { AID: 4, name: 'getDiscoveryDeviceId', payload: {} } Apr 24 15:01:24 zero volumio[851]: ] Apr 24 15:01:24 zero volumio[851]: verbose: ----------------------------------- Apr 24 15:01:24 zero volumio[851]: verbose: [yt-cast-receiver] (AID: 2) (YouTube Music) Incoming message: 'loungeStatus' Apr 24 15:01:24 zero volumio[851]: verbose: [yt-cast-receiver] Connecting to RPC URL: https://www.youtube.com/api/lounge/bc/bind?AID=3&CI=0&RID=rpc&SID=82EE9E0180093168&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=lEqSoznOrTmDUQUTvNLZqRYBcWK117sWeL2CeYQoabA&id=d23b40c7-a779-4ac5-8fa3-143b46148b7c&loungeIdToken=AGdO5p_qAJ4C8OozYH-g4Lx2s-FrABkcWFxtGEXl3h7Ovgxlehbswc5uiXEZx7QDFB2_mAcBpij-ouVzKHXDiHViqZ7w6NjGpnCZFsyQcfUxKjiWjsjbxDs&mdxVersion=2&name=YouTube%20on%20Zero&obfuscatedGaiaId=&t=1&theme=m&v=2&zx=05d6eff5706c Apr 24 15:01:24 zero volumio[851]: verbose: [yt-cast-receiver] (YouTube) Received messages for establishing session: Apr 24 15:01:24 zero volumio[851]: [ Apr 24 15:01:24 zero volumio[851]: Message { AID: 0, name: 'c', payload: [ '2479A0939CCDC285', '', 8 ] }, Apr 24 15:01:24 zero volumio[851]: Message { Apr 24 15:01:24 zero volumio[851]: AID: 1, Apr 24 15:01:24 zero volumio[851]: name: 'S', Apr 24 15:01:24 zero volumio[851]: payload: 'KrDfl4aiHIBscqukSMtUKUTctA9mfxGNKYcs5m4Hktw' Apr 24 15:01:24 zero volumio[851]: }, Apr 24 15:01:24 zero volumio[851]: Message { Apr 24 15:01:24 zero volumio[851]: AID: 2, Apr 24 15:01:24 zero volumio[851]: name: 'loungeStatus', Apr 24 15:01:24 zero volumio[851]: payload: { Apr 24 15:01:24 zero volumio[851]: queueId: 'RQR8EZggreRSv15-jwERRqi2Kli9o', Apr 24 15:01:24 zero volumio[851]: devices: '[{"app":"ytcr","capabilities":"dsp,mic,dpa,ntb,que,mus","clientName":"unknown","experiments":"","name":"YouTube on Zero","theme":"cl","id":"b09c8eaa-61a9-47d1-8655-fee1bad2fba5","type":"LOUNGE_SCREEN","hasCc":"true","deviceInfo":"{\\"year\\":0,\\"os\\":\\"Windows\\",\\"osVersion\\":\\"10.0\\",\\"chipset\\":\\"\\",\\"clientName\\":\\"TVHTML5\\",\\"dialAdditionalDataSupportLevel\\":\\"unsupported\\",\\"mdxDialServerType\\":\\"MDX_DIAL_SERVER_TYPE_UNKNOWN\\",\\"brand\\":\\"Generic\\",\\"model\\":\\"SmartTV\\"}","receiverIdentityMatchStatus":"IS_RECEIVER"}]', Apr 24 15:01:24 zero volumio[851]: connectionEventDetails: '{"deviceId":"b09c8eaa-61a9-47d1-8655-fee1bad2fba5"}' Apr 24 15:01:24 zero volumio[851]: } Apr 24 15:01:24 zero volumio[851]: }, Apr 24 15:01:24 zero volumio[851]: Message { AID: 3, name: 'getNowPlaying', payload: {} }, Apr 24 15:01:24 zero volumio[851]: Message { AID: 4, name: 'getDiscoveryDeviceId', payload: {} } Apr 24 15:01:24 zero volumio[851]: ] Apr 24 15:01:24 zero volumio[851]: verbose: ----------------------------------- Apr 24 15:01:24 zero volumio[851]: verbose: [yt-cast-receiver] (AID: 2) (YouTube) Incoming message: 'loungeStatus' Apr 24 15:01:24 zero volumio[851]: verbose: [yt-cast-receiver] Connecting to RPC URL: https://www.youtube.com/api/lounge/bc/bind?AID=3&CI=0&RID=rpc&SID=2479A0939CCDC285&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=KrDfl4aiHIBscqukSMtUKUTctA9mfxGNKYcs5m4Hktw&id=b09c8eaa-61a9-47d1-8655-fee1bad2fba5&loungeIdToken=AGdO5p_ErV6g0eyUnb-snPsKk_Yogj9leBkpVMXi33ONLq9evov2BJn07VUTc0yh-zCpJhd-zlNU6UZkt4AJRiZdKCD0u2LZtVjEa27RH6_BSOk7eKwH7K4&mdxVersion=2&name=YouTube%20on%20Zero&obfuscatedGaiaId=&t=1&theme=cl&v=2&zx=8b7d918d10bc Apr 24 15:01:25 zero volumio[851]: verbose: [yt-cast-receiver] RPC connection established. Apr 24 15:01:25 zero volumio[851]: verbose: [yt-cast-receiver] (YouTube) Session established. Apr 24 15:01:25 zero volumio[851]: verbose: [yt-cast-receiver] (YouTube) Saving MDX context to data store: Apr 24 15:01:25 zero volumio[851]: { Apr 24 15:01:25 zero volumio[851]: deviceId: 'b09c8eaa-61a9-47d1-8655-fee1bad2fba5', Apr 24 15:01:25 zero volumio[851]: screenId: '79t767efofk6v1tep43qs0h93s' Apr 24 15:01:25 zero volumio[851]: } Apr 24 15:01:25 zero volumio[851]: verbose: ----------------------------------- Apr 24 15:01:25 zero volumio[851]: verbose: [yt-cast-receiver] (AID: 4) (YouTube) Incoming message: 'getDiscoveryDeviceId' Apr 24 15:01:25 zero volumio[851]: verbose: [yt-cast-receiver] (AID: 4) (YouTube) Not handled: 'getDiscoveryDeviceId' Apr 24 15:01:25 zero volumio[851]: verbose: [yt-cast-receiver] RPC connection established. Apr 24 15:01:25 zero volumio[851]: verbose: [yt-cast-receiver] (YouTube Music) Session established. Apr 24 15:01:25 zero volumio[851]: verbose: [yt-cast-receiver] (YouTube Music) Saving MDX context to data store: Apr 24 15:01:25 zero volumio[851]: { Apr 24 15:01:25 zero volumio[851]: deviceId: 'd23b40c7-a779-4ac5-8fa3-143b46148b7c', Apr 24 15:01:25 zero volumio[851]: screenId: 'qbs9eq2sphvv2o0lhh0c2f1dpp' Apr 24 15:01:25 zero volumio[851]: } Apr 24 15:01:25 zero volumio[851]: verbose: [yt-cast-receiver] Starting DIAL server... Apr 24 15:01:25 zero volumio[851]: info: [yt-cast-receiver] DIAL server listening on port 8098 Apr 24 15:01:25 zero volumio[1087]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 24 15:01:25 zero volumio[851]: info: CoreCommandRouter::volumioRetrievevolume Apr 24 15:01:25 zero volumio[851]: verbose: ----------------------------------- Apr 24 15:01:25 zero volumio[851]: verbose: [yt-cast-receiver] (AID: 4) (YouTube Music) Incoming message: 'getDiscoveryDeviceId' Apr 24 15:01:25 zero volumio[851]: verbose: [yt-cast-receiver] (AID: 4) (YouTube Music) Not handled: 'getDiscoveryDeviceId' Apr 24 15:01:25 zero volumio[851]: info: Initializing connection to go-librespot Websocket Apr 24 15:01:25 zero go-librespot[1127]: time="2025-04-24T15:01:25-05:00" level=debug msg="new websocket client" Apr 24 15:01:25 zero volumio[851]: info: Connection to go-librespot Websocket established Apr 24 15:01:25 zero volumio[851]: info: VolumeController:: Volume=64 Mute =false Apr 24 15:01:25 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:25 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:25 zero volumio[851]: info: CoreStateMachine::pushState Apr 24 15:01:25 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:25 zero volumio[851]: info: CoreCommandRouter::volumioPushState Apr 24 15:01:25 zero volumio[851]: verbose: [ytcr] VolumeControl initialized with current volume: Apr 24 15:01:25 zero volumio[851]: { level: 64, muted: false } Apr 24 15:01:25 zero volumio[851]: verbose: [ytcr] MPD connected Apr 24 15:01:25 zero volumio[851]: verbose: [ytcr] MPDSubsystemEventEmitter enabled. Apr 24 15:01:25 zero volumio[851]: verbose: [ytcr] Receiver started with options: Apr 24 15:01:25 zero volumio[851]: { Apr 24 15:01:25 zero volumio[851]: dial: { port: 8098, bindToInterfaces: [ 'wlan0' ] }, Apr 24 15:01:25 zero volumio[851]: app: { Apr 24 15:01:25 zero volumio[851]: enableAutoplayOnConnect: true, Apr 24 15:01:25 zero volumio[851]: resetPlayerOnDisconnectPolicy: 'allExplicitlyDisconnected' Apr 24 15:01:25 zero volumio[851]: }, Apr 24 15:01:25 zero volumio[851]: dataStore: ReceiverDataStore {}, Apr 24 15:01:25 zero volumio[851]: logger: Logger { level: 'debug', color: true }, Apr 24 15:01:25 zero volumio[851]: logLevel: 'debug', Apr 24 15:01:25 zero volumio[851]: device: { name: 'Zero' } Apr 24 15:01:25 zero volumio[851]: } Apr 24 15:01:25 zero volumio[851]: info: Completed starting Core Plugins Apr 24 15:01:25 zero volumio[851]: info: ------------------------------------------- Apr 24 15:01:25 zero volumio[851]: info: ----- MyVolumio plugins startup ---- Apr 24 15:01:25 zero volumio[851]: info: ------------------------------------------- Apr 24 15:01:25 zero volumio[851]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 24 15:01:27 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:27 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:28 zero volumio[851]: info: Getting Spotify volume Apr 24 15:01:28 zero volumio[851]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Apr 24 15:01:28 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:28 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:28 zero volumio[851]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Apr 24 15:01:28 zero volumio[851]: SPOTIFY: SPOTIFY VOLUME undefined Apr 24 15:01:28 zero volumio[851]: SPOTIFY: VOLUMIO VOLUME 64 Apr 24 15:01:28 zero volumio[851]: info: Aligning Spotify Volume to Volumio Volume Apr 24 15:01:28 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:28 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:28 zero volumio[851]: info: Setting Spotify Volume from Volumio: 64 Apr 24 15:01:29 zero volumio[851]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 24 15:01:29 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 15:01:29 zero volumio[851]: info: CURURI: music-library Apr 24 15:01:30 zero volumio[1087]: ...............................++++ Apr 24 15:01:30 zero volumio[851]: SPOTIFY: SETTING SPOTIFY VOLUME 64 Apr 24 15:01:30 zero volumio[851]: info: Sending Spotify command with payload to local API: /player/volume Apr 24 15:01:30 zero volumio[851]: info: Preload queue cleared Apr 24 15:01:32 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 15:01:32 zero volumio[851]: info: CURURI: music-library/INTERNAL Apr 24 15:01:32 zero volumio[851]: info: Preload queue cleared Apr 24 15:01:33 zero ntpd[680]: Soliciting pool server 179.60.247.252 Apr 24 15:01:33 zero ntpd[680]: Soliciting pool server 179.60.247.252 Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 24 15:01:34 zero volumio[851]: info: Adding plugin bluetooth to MyMusic Plugins Apr 24 15:01:34 zero volumio[851]: info: Adding plugin multiroom to MyMusic Plugins Apr 24 15:01:34 zero volumio[851]: info: Adding plugin metavolumio to MyMusic Plugins Apr 24 15:01:34 zero volumio[851]: info: Adding plugin cd_controller to MyMusic Plugins Apr 24 15:01:34 zero volumio[851]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 24 15:01:34 zero volumio[851]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 24 15:01:34 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 24 15:01:35 zero ntpd[680]: Soliciting pool server 2001:12ff:0:7::197 Apr 24 15:01:37 zero volumio[851]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 24 15:01:37 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 24 15:01:37 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:37 zero volumio[851]: info: Starting MyVolumio Remote Streaming Endpoints Apr 24 15:01:37 zero volumio[851]: info: MyVolumio login type: Token Apr 24 15:01:37 zero volumio[851]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 24 15:01:37 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 24 15:01:39 zero volumio[851]: info: Starting Streaming Service Transparent Proxy Apr 24 15:01:39 zero volumio[851]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 24 15:01:39 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 24 15:01:39 zero volumio[851]: info: Streaming services startup Apr 24 15:01:39 zero volumio[851]: info: Starting Streaming Daemon Apr 24 15:01:40 zero volumio[851]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 24 15:01:40 zero sudo[1310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 24 15:01:40 zero sudo[1310]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:40 zero volumio[1087]: ..........................................................++++ Apr 24 15:01:40 zero volumio[1087]: e is 65537 (0x010001) Apr 24 15:01:40 zero volumio[1087]: writing RSA key Apr 24 15:01:40 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 15:01:40 zero volumio[851]: info: CURURI: music-library/INTERNAL/Spotify 2 Apr 24 15:01:40 zero volumio[851]: info: Preload queue cleared Apr 24 15:01:40 zero sudo[1310]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:40 zero volumio[851]: error: Cannot start Volumio Streaming Daemon Apr 24 15:01:40 zero volumio[851]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 24 15:01:40 zero volumio[851]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 24 15:01:41 zero volumio[851]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 24 15:01:43 zero volumio[851]: info: MyVolumio token set successfully Apr 24 15:01:43 zero volumio[851]: info: MYVOLUMIO: Adding device Apr 24 15:01:43 zero volumio[851]: info: MYVOLUMIO: Evaluating Server Apr 24 15:01:43 zero volumio[851]: info: MyVolumio Plan changed: premium Apr 24 15:01:43 zero volumio[851]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Apr 24 15:01:43 zero volumio[851]: info: Removing browser output: myVolumio user plan is not superstar Apr 24 15:01:43 zero volumio[851]: info: Removing audio output: Apr 24 15:01:43 zero volumio[851]: info: MYVOLUMIO: Adding device Apr 24 15:01:43 zero volumio[851]: info: MYVOLUMIO: Evaluating Server Apr 24 15:01:43 zero volumio[851]: info: Remote config written successfully Apr 24 15:01:43 zero volumio[851]: info: Starting Tunnel 1 Apr 24 15:01:43 zero volumio[851]: info: Starting Tunnel Connection Checker Apr 24 15:01:43 zero volumio[851]: info: Completed starting MyVolumio Plugin Apr 24 15:01:43 zero volumio[851]: STREAMING PROXY: Starting server on port 3245 Apr 24 15:01:43 zero volumio[851]: Node JS runtime: 14 Apr 24 15:01:44 zero volumio[851]: info: MYVolumio Device enabled Apr 24 15:01:44 zero volumio[851]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Apr 24 15:01:44 zero volumio[851]: info: MyVolumio status changed Apr 24 15:01:44 zero volumio[851]: info: Streaming services startup Apr 24 15:01:44 zero volumio[851]: info: Starting Streaming Daemon Apr 24 15:01:44 zero sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 24 15:01:44 zero sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:44 zero volumio[851]: info: Setting Geolocation for MyVolumio to us1 Apr 24 15:01:44 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:44 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:44 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:44 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:44 zero sudo[1375]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:44 zero volumio[851]: error: Cannot start Volumio Streaming Daemon Apr 24 15:01:44 zero volumio[851]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 24 15:01:44 zero volumio[851]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 24 15:01:44 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 24 15:01:44 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:44 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Apr 24 15:01:44 zero volumio[851]: info: [1745524904983] Starting BluetoothController Apr 24 15:01:45 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Apr 24 15:01:47 zero volumio[851]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Apr 24 15:01:47 zero sudo[1378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Apr 24 15:01:47 zero sudo[1378]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:47 zero sudo[1378]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:47 zero volumio[851]: info: MRS: MultiRoom plugin initialized Apr 24 15:01:47 zero volumio[851]: info: MRS: STOPPING SNAPCLIENT Apr 24 15:01:47 zero volumio[851]: info: MRS: Snap server stop Apr 24 15:01:47 zero sudo[1394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Apr 24 15:01:47 zero sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:47 zero volumio[851]: info: MRS: STOPPING volumioStreaming Apr 24 15:01:47 zero sudo[1397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Apr 24 15:01:47 zero sudo[1397]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:47 zero sudo[1400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Apr 24 15:01:47 zero sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:47 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Apr 24 15:01:47 zero sudo[1403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Apr 24 15:01:47 zero sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:47 zero sudo[1403]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:47 zero sudo[1394]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:47 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Apr 24 15:01:47 zero sudo[1400]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:47 zero sudo[1397]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:47 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Apr 24 15:01:47 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Apr 24 15:01:47 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Apr 24 15:01:48 zero volumio[851]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Apr 24 15:01:48 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Apr 24 15:01:48 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Apr 24 15:01:48 zero volumio[851]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Apr 24 15:01:48 zero volumio[851]: info: Preparing to generate the ALSA configuration file Apr 24 15:01:48 zero volumio[851]: info: Updating MyVolumio device info Apr 24 15:01:48 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:48 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:48 zero volumio[851]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Apr 24 15:01:48 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:48 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 24 15:01:48 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:48 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 24 15:01:48 zero volumio[851]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 24 15:01:48 zero volumio[851]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 24 15:01:48 zero volumio[851]: info: Reading ALSA contributions from plugins. Apr 24 15:01:48 zero volumio[851]: info: Setting Geolocation for MyVolumio to us1 Apr 24 15:01:48 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:48 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:48 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:48 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:48 zero volumio[851]: info: MRS: Removed streaming files Apr 24 15:01:48 zero volumio[851]: info: MRS: volumioStreaming STOPPED Apr 24 15:01:48 zero volumio[851]: info: MRS: SNAPSERVER STOPPED Apr 24 15:01:48 zero volumio[851]: info: MRS: SNAPCLIENT STOPPED Apr 24 15:01:48 zero volumio[851]: info: Asound.conf file written Apr 24 15:01:48 zero sudo[1408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 24 15:01:48 zero sudo[1408]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:48 zero sudo[1408]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:49 zero volumio[851]: info: Output device has changed, restarting MPD Apr 24 15:01:49 zero sudo[1413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 24 15:01:49 zero sudo[1413]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:49 zero sudo[1413]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:49 zero volumio[851]: info: Output device has changed, restarting Shairport Sync Apr 24 15:01:49 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:49 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:49 zero sudo[1416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 24 15:01:49 zero sudo[1416]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:49 zero systemd[1]: Stopping Music Player Daemon... Apr 24 15:01:49 zero volumio[851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 15:01:49 zero volumio[851]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 24 15:01:49 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:49 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Apr 24 15:01:49 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 24 15:01:49 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Apr 24 15:01:49 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Apr 24 15:01:49 zero volumio[851]: info: MRS: Pushing multiroomSync output for this device Apr 24 15:01:49 zero volumio[851]: info: MRS: Pushing multiroomSync output Apr 24 15:01:49 zero sudo[1424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Zero Apr 24 15:01:49 zero sudo[1424]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:49 zero volumio[851]: info: Adding audio output: Apr 24 15:01:49 zero volumio[851]: info: Adding audio output: Apr 24 15:01:49 zero sudo[1424]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:49 zero volumio[851]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 24 15:01:49 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:49 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Apr 24 15:01:49 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:49 zero volumio[851]: info: Adding METAVOLUMIO REST API Endpoints Apr 24 15:01:49 zero volumio[851]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 24 15:01:49 zero volumio[851]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Apr 24 15:01:49 zero volumio[851]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Apr 24 15:01:49 zero volumio[851]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Apr 24 15:01:49 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Apr 24 15:01:49 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Apr 24 15:01:49 zero volumio[851]: info: Preparing CD Folders Apr 24 15:01:49 zero volumio[851]: info: Adding CD REST API Endpoints Apr 24 15:01:49 zero volumio[851]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Apr 24 15:01:49 zero volumio[851]: info: Starting UDEV Watcher for CD Apr 24 15:01:49 zero volumio[851]: info: Detecting CD presence with UDEV Apr 24 15:01:49 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Apr 24 15:01:49 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Apr 24 15:01:49 zero volumio[851]: info: Adding inputs REST Endpoints Apr 24 15:01:49 zero volumio[851]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Apr 24 15:01:49 zero volumio[851]: info: Scanning Audio Inputs Apr 24 15:01:49 zero volumio[851]: info: Checking against Known Cards name Apr 24 15:01:49 zero volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:01:49 zero volumio[851]: info: [1745524909899] CoreMusicLibrary::Adding element USB Audio Device Apr 24 15:01:49 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:01:49 zero volumio[851]: Cannot find translation for source Calm Radio Apr 24 15:01:49 zero volumio[851]: Cannot find translation for source YouTube2 Apr 24 15:01:49 zero volumio[851]: Cannot find translation for source YouTube Music Apr 24 15:01:49 zero volumio[851]: Cannot find translation for source 80s80s Radio Apr 24 15:01:49 zero volumio[851]: Cannot find translation for source USB Audio Device Apr 24 15:01:49 zero volumio[851]: info: Checking against Known Cards name Apr 24 15:01:49 zero volumio[851]: info: Adding Server instance for streaming Apr 24 15:01:49 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Apr 24 15:01:49 zero volumio[851]: error: Hi Res Audio Failed Login: Missing Login Data Apr 24 15:01:49 zero volumio[851]: info: Adding HIGHRESAUDIO REST API Endpoints Apr 24 15:01:49 zero volumio[851]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Apr 24 15:01:49 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Apr 24 15:01:49 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Apr 24 15:01:49 zero volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Apr 24 15:01:50 zero volumio[851]: info: Stopping AccessToken refresher cron Apr 24 15:01:50 zero sudo[1446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 24 15:01:50 zero sudo[1446]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:50 zero sudo[1446]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:50 zero volumio[851]: info: AccessToken refresher cron started Apr 24 15:01:50 zero volumio[851]: info: Stopping AccessToken refresher cron for QOBUZ Apr 24 15:01:50 zero volumio[851]: info: AccessToken refresher cron started for QOBUZ Apr 24 15:01:50 zero volumio[851]: info: Adding TIDAL REST API Endpoints Apr 24 15:01:50 zero volumio[851]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Apr 24 15:01:50 zero volumio[851]: info: Adding QOBUZ REST API Endpoints Apr 24 15:01:50 zero volumio[851]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Apr 24 15:01:50 zero volumio[851]: info: Updating MyVolumio device info Apr 24 15:01:50 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:50 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:50 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:50 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:50 zero volumio[851]: info: Successfully Added MyVolumio device Apr 24 15:01:50 zero volumio[851]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Apr 24 15:01:50 zero volumio[851]: info: Bluetooth name changed to Zero Apr 24 15:01:50 zero volumio[851]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Apr 24 15:01:50 zero volumio[851]: info: MPD Permissions set Apr 24 15:01:50 zero volumio[851]: verbose: [ytcr] MPDSubsystemEventEmitter destroyed. Apr 24 15:01:50 zero volumio[851]: verbose: [ytcr] Cancelling prefetch (abortIfPrefetching: true, clearIfPrefetched: true) Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:51 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:51 zero volumio[851]: verbose: [ytcr] MPDPlayer going to sleep... Apr 24 15:01:51 zero volumio[851]: verbose: [ytcr] MPD disconnected. Reconnecting... Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 24 15:01:51 zero volumio[851]: info: Discovery: Getting this device information Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:51 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 24 15:01:51 zero volumio[851]: info: Successfully Added MyVolumio device Apr 24 15:01:51 zero volumio[851]: info: Starting Shairport Sync Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 24 15:01:51 zero volumio[851]: info: Discovery: Getting this device information Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:51 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:51 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 24 15:01:51 zero sudo[1461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 24 15:01:51 zero sudo[1461]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:51 zero sudo[1463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 24 15:01:51 zero sudo[1463]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:51 zero volumio[851]: info: MRS: Found cast device: Google-Nest-Hub-1013caa979b3c5073af1a5992a739e98 Apr 24 15:01:51 zero volumio[851]: info: Adding audio output: Apr 24 15:01:52 zero volumio[851]: verbose: New Socket.io Connection to 192.168.200.101:3000 from 192.168.200.19 UA: Dart/3.7 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Apr 24 15:01:52 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 24 15:01:52 zero systemd[1]: Started MyVolumio SSH Tunnel. Apr 24 15:01:52 zero systemd[1]: mpd.service: Succeeded. Apr 24 15:01:52 zero systemd[1]: Stopped Music Player Daemon. Apr 24 15:01:52 zero sudo[1461]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:52 zero volumio[851]: info: Remote SSH Started Apr 24 15:01:52 zero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 24 15:01:52 zero systemd[1]: Starting Music Player Daemon... Apr 24 15:01:52 zero systemd[1]: shairport-sync.service: Succeeded. Apr 24 15:01:52 zero systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 24 15:01:52 zero volumio-remote-updater[495]: No test mode Apr 24 15:01:52 zero volumio-remote-updater[495]: No alpha test mode Apr 24 15:01:52 zero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 24 15:01:52 zero sudo[1463]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:52 zero autossh[1470]: port set to 0, monitoring disabled Apr 24 15:01:52 zero autossh[1470]: starting ssh (count 1) Apr 24 15:01:52 zero autossh[1470]: ssh child pid is 1473 Apr 24 15:01:52 zero sudo[1467]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 24 15:01:52 zero sudo[1467]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:52 zero sudo[1467]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:52 zero volumio[851]: info: Successfully Updated MyVolumio device Apr 24 15:01:52 zero sudo[1479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Apr 24 15:01:52 zero sudo[1479]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:52 zero volumio[851]: info: Successfully Updated MyVolumio device Apr 24 15:01:52 zero systemd[1]: Started Volumio Bluetooth Module. Apr 24 15:01:52 zero sudo[1479]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:52 zero volumio[851]: info: Shairport-Sync Started Apr 24 15:01:52 zero sudo[1482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Apr 24 15:01:52 zero sudo[1482]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:52 zero volumiobt[1481]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Apr 24 15:01:52 zero sudo[1482]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:52 zero volumio[851]: info: Volumio BT Module successfully started Apr 24 15:01:52 zero volumio[851]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 24 15:01:52 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:52 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:52 zero volumio[851]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 24 15:01:52 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 24 15:01:53 zero volumio[851]: info: Preload queue cleared Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 15:01:53 zero volumio[851]: info: CoreStateMachine::ClearQueue Apr 24 15:01:53 zero volumio[851]: info: CoreStateMachine::stop Apr 24 15:01:53 zero volumiossh-tunnel[1466]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts. Apr 24 15:01:53 zero volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 15:01:53 zero volumio[851]: info: CorePlayQueue::clearPlayQueue Apr 24 15:01:53 zero volumio[851]: info: CorePlayQueue::saveQueue Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::volumioPushQueue Apr 24 15:01:53 zero volumio[851]: info: CoreStateMachine::addQueueItems Apr 24 15:01:53 zero volumio[851]: info: CorePlayQueue::addQueueItems Apr 24 15:01:53 zero volumio[851]: info: Preload queue cleared Apr 24 15:01:53 zero volumio[851]: info: Adding Item to queue: music-library/INTERNAL/Spotify 2/Oldies spotify Apr 24 15:01:53 zero volumio[851]: info: Exploding uri music-library/INTERNAL/Spotify 2/Oldies spotify in service mpd Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: error: MPD error: Error: This socket has been ended by the other party Apr 24 15:01:53 zero volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 24 15:01:53 zero volumio[851]: info: TidalConnect service stoped! Apr 24 15:01:53 zero volumio[851]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.19 UA: Mozilla/5.0 (Linux; Android 13; NTH-NX9 Build/HONORNTH-N29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.111 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Apr 24 15:01:53 zero volumio[851]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:53 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:53 zero sudo[1493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Apr 24 15:01:53 zero sudo[1493]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:53 zero volumio[851]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 24 15:01:53 zero volumio[851]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::volumioGetVisibleSources Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:53 zero volumiobt[1481]: pulseaudio: no process found Apr 24 15:01:53 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::volumioGetQueue Apr 24 15:01:53 zero sudo[1493]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:53 zero volumio[851]: info: CoreStateMachine::getQueue Apr 24 15:01:53 zero volumio[851]: info: CorePlayQueue::getQueue Apr 24 15:01:53 zero volumio[851]: info: Listing playlists Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 24 15:01:53 zero volumio[851]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 24 15:01:53 zero volumio[851]: info: Received Get System Info Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 24 15:01:53 zero volumio[851]: info: Discovery: Getting this device information Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:53 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::volumioGetState Apr 24 15:01:53 zero volumio[851]: info: CorePlayQueue::getTrack 0 Apr 24 15:01:53 zero volumio[851]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 24 15:01:53 zero volumio[851]: verbose: ----------------------------------- Apr 24 15:01:53 zero volumio[851]: verbose: [yt-cast-receiver] (AID: 5) (YouTube) Incoming message: 'noop' Apr 24 15:01:53 zero volumio[851]: verbose: [yt-cast-receiver] (AID: 5) (YouTube) Not handled: 'noop' Apr 24 15:01:53 zero sudo[1497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 24 15:01:53 zero sudo[1497]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:01:53 zero dbus-daemon[511]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.22' (uid=1000 pid=1500 comm="/usr/bin/pulseaudio --high-priority=true ") Apr 24 15:01:54 zero systemd[1]: Started Volumio Tidal Connect Service. Apr 24 15:01:54 zero sudo[1497]: pam_unix(sudo:session): session closed for user root Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero systemd[1]: Starting RealtimeKit Scheduling Policy Service... Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero dbus-daemon[511]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Apr 24 15:01:54 zero systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero rtkit-daemon[1504]: Successfully called chroot. Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero rtkit-daemon[1504]: Successfully dropped privileges. Apr 24 15:01:54 zero rtkit-daemon[1504]: Successfully limited resources. Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero rtkit-daemon[1504]: Running. Apr 24 15:01:54 zero rtkit-daemon[1504]: Watchdog thread running. Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero dbus-daemon[511]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.23' (uid=0 pid=1504 comm="/usr/lib/rtkit/rtkit-daemon ") Apr 24 15:01:54 zero rtkit-daemon[1504]: Canary thread running. Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:01:54 zero systemd[1]: Starting Authorization Manager... Apr 24 15:01:54 zero volumio[851]: info: MRS: Getting audio outputs on start Apr 24 15:01:54 zero volumio[851]: info: MRS: Requesting all other devices output Apr 24 15:01:54 zero volumio[851]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 24 15:01:54 zero volumio[851]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 24 15:01:54 zero polkitd[1507]: started daemon version 0.105 using authority implementation `local' version `0.105' Apr 24 15:01:54 zero dbus-daemon[511]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 24 15:01:54 zero systemd[1]: Started Authorization Manager. Apr 24 15:01:55 zero pulseaudio[1500]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 24 15:01:55 zero pulseaudio[1500]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 24 15:01:55 zero volumiobt[1481]: Applying permissions Apr 24 15:01:55 zero volumiobt[1481]: Setting BT discoverable and pairable Apr 24 15:01:55 zero bluetoothd[657]: Endpoint registered: sender=:1.43 path=/MediaEndpoint/A2DPSource Apr 24 15:01:55 zero pulseaudio[1500]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Apr 24 15:01:55 zero bluetoothd[657]: Endpoint registered: sender=:1.43 path=/MediaEndpoint/A2DPSink Apr 24 15:01:55 zero kernel: Bluetooth: RFCOMM TTY layer initialized Apr 24 15:01:55 zero kernel: Bluetooth: RFCOMM socket layer initialized Apr 24 15:01:55 zero kernel: Bluetooth: RFCOMM ver 1.11 Apr 24 15:01:55 zero volumiobt[1481]: [CHG] Controller D8:3A:DD:8F:EA:FE Class: 0x0008041c Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [91B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [117B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [55B blob data] Apr 24 15:01:55 zero volumiobt[1481]: [bluetooth]# -e power on Apr 24 15:01:55 zero volumiobt[1481]: Invalid command in menu main: -e Apr 24 15:01:55 zero volumiobt[1481]: Apr 24 15:01:55 zero volumiobt[1481]: Use "help" for a list of available commands in a menu. Apr 24 15:01:55 zero volumiobt[1481]: Use "menu " if you want to enter any submenu. Apr 24 15:01:55 zero volumiobt[1481]: Use "back" if you want to return to menu main. Apr 24 15:01:55 zero volumiobt[1481]: [bluetooth]# agent on Apr 24 15:01:55 zero volumiobt[1481]: Agent is already registered Apr 24 15:01:55 zero volumiobt[1481]: [bluetooth]# discoverable on Apr 24 15:01:55 zero volumiobt[1481]: [bluetooth]# pairable on Apr 24 15:01:55 zero volumiobt[1481]: [bluetooth]# agent NoInputNoOutput Apr 24 15:01:55 zero volumiobt[1481]: Agent is already registered Apr 24 15:01:55 zero volumiobt[1481]: [bluetooth]# default-agent Apr 24 15:01:55 zero volumiobt[1481]: [bluetooth]# quit Apr 24 15:01:55 zero volumiobt[1481]: [59B blob data] Apr 24 15:01:56 zero mpd[1475]: Apr 24 15:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 24 15:01:56 zero systemd[1]: Started Music Player Daemon. Apr 24 15:01:56 zero sudo[1416]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:04 zero volumio[851]: <--- Last few GCs ---> Apr 24 15:02:04 zero volumio[851]: [851:0x5520788] 82119 ms: Mark-sweep 125.9 (129.2) -> 124.6 (128.7) MB, 717.7 / 0.2 ms (average mu = 0.485, current mu = 0.256) allocation failure scavenge might not succeed Apr 24 15:02:04 zero volumio[851]: [851:0x5520788] 82151 ms: Scavenge 125.2 (128.7) -> 125.0 (128.7) MB, 5.7 / 0.0 ms (average mu = 0.485, current mu = 0.256) allocation failure Apr 24 15:02:04 zero volumio[851]: [851:0x5520788] 82170 ms: Scavenge 125.2 (128.7) -> 125.1 (128.9) MB, 8.2 / 0.0 ms (average mu = 0.485, current mu = 0.256) allocation failure Apr 24 15:02:04 zero volumio[851]: <--- JS stacktrace ---> Apr 24 15:02:04 zero volumio[851]: FATAL ERROR: MarkCompactCollector: young object promotion failed Allocation failed - JavaScript heap out of memory Apr 24 15:02:04 zero vtcs[1501]: BYE TidalConnect Apr 24 15:02:04 zero systemd[1]: volumio.service: Main process exited, code=killed, status=6/ABRT Apr 24 15:02:04 zero volumio-remote-updater[495]: [2025-04-24 15:02:04] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 24 15:02:04 zero volumio-remote-updater[495]: [2025-04-24 15:02:04] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 24 15:02:04 zero systemd[1]: volumio.service: Failed with result 'signal'. Apr 24 15:02:04 zero systemd[1]: Started dynamicswap service. Apr 24 15:02:04 zero systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 24 15:02:04 zero systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Apr 24 15:02:04 zero systemd[1]: Stopped Volumio Backend Module. Apr 24 15:02:04 zero systemd[1]: Started Volumio Backend Module. Apr 24 15:02:04 zero go-librespot[1127]: time="2025-04-24T15:02:04-05:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Apr 24 15:02:04 zero systemd[1]: dynamicswap.service: Succeeded. Apr 24 15:02:04 zero systemd[1]: vtcs.service: Succeeded. Apr 24 15:02:05 zero systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Apr 24 15:02:05 zero systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 1. Apr 24 15:02:05 zero systemd[1]: Stopped Volumio Tidal Connect Service. Apr 24 15:02:05 zero systemd[1]: Started Volumio Tidal Connect Service. Apr 24 15:02:05 zero vtcs[1549]: BYE TidalConnect Apr 24 15:02:05 zero systemd[1]: vtcs.service: Succeeded. Apr 24 15:02:05 zero systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Apr 24 15:02:05 zero systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 2. Apr 24 15:02:05 zero systemd[1]: Stopped Volumio Tidal Connect Service. Apr 24 15:02:05 zero systemd[1]: Started Volumio Tidal Connect Service. Apr 24 15:02:06 zero vtcs[1552]: BYE TidalConnect Apr 24 15:02:06 zero systemd[1]: vtcs.service: Succeeded. Apr 24 15:02:06 zero systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Apr 24 15:02:06 zero systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 3. Apr 24 15:02:06 zero systemd[1]: Stopped Volumio Tidal Connect Service. Apr 24 15:02:06 zero systemd[1]: Started Volumio Tidal Connect Service. Apr 24 15:02:06 zero vtcs[1555]: BYE TidalConnect Apr 24 15:02:06 zero systemd[1]: vtcs.service: Succeeded. Apr 24 15:02:07 zero systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Apr 24 15:02:07 zero systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 4. Apr 24 15:02:07 zero systemd[1]: Stopped Volumio Tidal Connect Service. Apr 24 15:02:07 zero systemd[1]: Started Volumio Tidal Connect Service. Apr 24 15:02:08 zero volumio[1537]: info: ------------------------------------------- Apr 24 15:02:08 zero volumio[1537]: info: ----- Volumio3 ---- Apr 24 15:02:08 zero volumio[1537]: info: ------------------------------------------- Apr 24 15:02:08 zero volumio[1537]: info: ----- System startup ---- Apr 24 15:02:08 zero volumio[1537]: info: ------------------------------------------- Apr 24 15:02:09 zero volumio-remote-updater[495]: [2025-04-24 15:02:09] [connect] Successful connection Apr 24 15:02:09 zero volumio[1537]: info: MYVOLUMIO Environment detected Apr 24 15:02:09 zero volumio[1537]: info: Plugin folders cleanup Apr 24 15:02:09 zero volumio[1537]: info: Scanning into folder /volumio/app/plugins/ Apr 24 15:02:09 zero volumio[1537]: info: Scanning category audio_interface Apr 24 15:02:09 zero volumio[1537]: info: Scanning category miscellanea Apr 24 15:02:09 zero volumio[1537]: info: Scanning category music_service Apr 24 15:02:09 zero volumio[1537]: info: Scanning category plugins.json Apr 24 15:02:09 zero volumio[1537]: info: Scanning category system_controller Apr 24 15:02:09 zero volumio[1537]: info: Scanning category user_interface Apr 24 15:02:09 zero volumio[1537]: info: Scanning into folder /data/plugins/ Apr 24 15:02:09 zero volumio[1537]: info: Scanning category audio_interface Apr 24 15:02:09 zero volumio[1537]: info: Scanning category music_service Apr 24 15:02:09 zero volumio[1537]: info: Plugin folders cleanup completed Apr 24 15:02:09 zero volumio[1537]: info: ------------------------------------------- Apr 24 15:02:09 zero volumio[1537]: info: ----- Core plugins startup ---- Apr 24 15:02:09 zero volumio[1537]: info: ------------------------------------------- Apr 24 15:02:09 zero volumio[1537]: info: Loading plugins from folder /volumio/app/plugins/ Apr 24 15:02:09 zero volumio[1537]: info: Adding plugin upnp to MyMusic Plugins Apr 24 15:02:09 zero volumio[1537]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 24 15:02:09 zero volumio[1537]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 24 15:02:09 zero volumio[1537]: info: Loading plugins from folder /data/plugins/ Apr 24 15:02:09 zero volumio[1537]: info: Loading plugin "system"... Apr 24 15:02:10 zero volumio[1537]: info: Loading plugin "appearance"... Apr 24 15:02:11 zero volumio[1537]: info: Loading plugin "network"... Apr 24 15:02:11 zero volumio[1537]: info: Refreshing Cached IP Addresses Apr 24 15:02:11 zero sudo[1577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 15:02:11 zero volumio[1537]: info: Loading plugin "services"... Apr 24 15:02:11 zero sudo[1577]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:11 zero volumio[1537]: info: Loading plugin "alsa_controller"... Apr 24 15:02:11 zero sudo[1575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 24 15:02:11 zero sudo[1575]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:11 zero sudo[1577]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:12 zero sudo[1584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 24 15:02:12 zero sudo[1584]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:12 zero sudo[1575]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:12 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 24 15:02:12 zero volumio[1537]: info: Loading plugin "wizard"... Apr 24 15:02:12 zero volumio[1537]: info: Loading plugin "networkfs"... Apr 24 15:02:12 zero volumio[1537]: info: Starting Udev Watcher for removable devices Apr 24 15:02:12 zero volumio[1537]: info: Ignoring mount for partition: boot Apr 24 15:02:12 zero volumio[1537]: info: Ignoring mount for partition: volumio Apr 24 15:02:12 zero volumio[1537]: info: Ignoring mount for partition: volumio_data Apr 24 15:02:12 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 24 15:02:12 zero volumio[1537]: info: Loading plugin "volumio_command_line_client"... Apr 24 15:02:12 zero volumio[1537]: info: Loading plugin "upnp"... Apr 24 15:02:12 zero volumio[1537]: info: [1745524932399] Starting Upmpd Daemon Apr 24 15:02:12 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 24 15:02:12 zero volumio[1537]: info: Loading plugin "my_music"... Apr 24 15:02:12 zero volumio[1537]: info: Loading plugin "mpd"... Apr 24 15:02:12 zero sudo[1584]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:13 zero volumio[1537]: info: Loading plugin "upnp_browser"... Apr 24 15:02:13 zero volumio[1537]: info: Loading plugin "alarm-clock"... Apr 24 15:02:13 zero volumio[1537]: info: Loading plugin "airplay_emulation"... Apr 24 15:02:13 zero volumio[1537]: info: Starting Shairport Sync Apr 24 15:02:13 zero volumio[1537]: info: Loading plugin "last_100"... Apr 24 15:02:13 zero volumio[1537]: info: Loading plugin "webradio"... Apr 24 15:02:14 zero volumio[1537]: info: Loading plugin "i2s_dacs"... Apr 24 15:02:14 zero volumio[1537]: info: I2S DAC not set, start Auto-detection Apr 24 15:02:14 zero volumio[1537]: info: Loading plugin "volumiodiscovery"... Apr 24 15:02:14 zero volumio[1537]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 24 15:02:14 zero volumio[1537]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 24 15:02:14 zero volumio[1537]: *** WARNING *** For more information see Apr 24 15:02:14 zero volumio[1537]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 24 15:02:14 zero volumio[1537]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 24 15:02:14 zero volumio[1537]: *** WARNING *** For more information see Apr 24 15:02:14 zero node[1537]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 24 15:02:14 zero node[1537]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 24 15:02:14 zero node[1537]: *** WARNING *** For more information see Apr 24 15:02:14 zero node[1537]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 24 15:02:14 zero node[1537]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 24 15:02:14 zero node[1537]: *** WARNING *** For more information see Apr 24 15:02:14 zero volumio[1537]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 24 15:02:14 zero volumio[1537]: info: Discovery: Started advertising with name: Zero Apr 24 15:02:14 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 24 15:02:14 zero volumio[1537]: info: Loading plugin "calmradio"... Apr 24 15:02:15 zero volumio[1537]: info: Loading plugin "spop"... Apr 24 15:02:17 zero volumio[1537]: info: Loading plugin "youtube2"... Apr 24 15:02:21 zero volumio-remote-updater[495]: [2025-04-24 15:02:21] [connect] Successful connection Apr 24 15:02:22 zero volumio[1537]: info: Loading plugin "ytcr"... Apr 24 15:02:29 zero volumio[1537]: info: Loading plugin "ytmusic"... Apr 24 15:02:34 zero volumio[1537]: info: Loading plugin "outputs"... Apr 24 15:02:34 zero volumio[1537]: info: Loading plugin "albumart"... Apr 24 15:02:34 zero volumio[1537]: info: Plugin example_plugin is not enabled Apr 24 15:02:34 zero volumio[1537]: info: Loading plugin "inputs"... Apr 24 15:02:34 zero volumio[1537]: info: Loading plugin "updater_comm"... Apr 24 15:02:34 zero volumio[1537]: info: Plugin mpdemulation is not enabled Apr 24 15:02:34 zero volumio[1537]: info: Loading plugin "rest_api"... Apr 24 15:02:34 zero volumio[1537]: info: Loading plugin "websocket"... Apr 24 15:02:34 zero volumio[1537]: info: Starting Socket.io Server version 2.3.0 Apr 24 15:02:34 zero volumio[1537]: info: Loading plugin "fusiondsp"... Apr 24 15:02:34 zero volumio[1537]: Forking 3 albumart workers Apr 24 15:02:35 zero volumio[1537]: info: Applying required configuration parameters for plugin fusiondsp Apr 24 15:02:35 zero volumio[1537]: info: Loading plugin "80s80s"... Apr 24 15:02:36 zero volumio[1537]: info: Applying required configuration parameters for plugin 80s80s Apr 24 15:02:36 zero volumio[1537]: info: [1745524956145] [80s80s] API delay: 30 Apr 24 15:02:36 zero volumio[1537]: info: Loading i18n strings for locale es Apr 24 15:02:36 zero volumio[1537]: Updating browse sources language Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:02:36 zero volumio[1537]: Starting albumart workers Apr 24 15:02:36 zero volumio[1537]: Starting albumart workers Apr 24 15:02:36 zero volumio[1537]: Starting albumart workers Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::initPlayerControls Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 15:02:36 zero volumio[1537]: Express server listening on port 3000 Apr 24 15:02:36 zero volumio[1537]: [Metrics] WebUI: 29s 573.46ms Apr 24 15:02:36 zero volumio[1537]: info: CoreStateMachine::resetVolumioState Apr 24 15:02:36 zero volumio[1537]: info: CoreStateMachine::getcurrentVolume Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::volumioRetrievevolume Apr 24 15:02:36 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:02:36 zero volumio-remote-updater[495]: [2025-04-24 15:02:36] [connect] Successful connection Apr 24 15:02:37 zero volumio[1537]: info: Volumio Network Manager: Network status updated: 2 Apr 24 15:02:37 zero sudo[1708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 24 15:02:37 zero sudo[1710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 15:02:37 zero sudo[1710]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:37 zero sudo[1708]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:37 zero sudo[1710]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:37 zero volumio[1537]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 1 Apr 24 15:02:37 zero sudo[1708]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:37 zero volumio[1537]: info: No valid Plugin REST Endpoint Apr 24 15:02:37 zero vtcs[1558]: BYE TidalConnect Apr 24 15:02:37 zero volumio[1537]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 2 Apr 24 15:02:37 zero volumio[1537]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 3 Apr 24 15:02:37 zero volumio[1537]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 4 Apr 24 15:02:37 zero volumio[1537]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 5 Apr 24 15:02:37 zero volumio[1537]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 6 Apr 24 15:02:37 zero volumio-remote-updater[495]: [2025-04-24 15:02:37] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745524956 101 Apr 24 15:02:37 zero volumio[1537]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 7 Apr 24 15:02:37 zero volumio[1537]: info: Reloading queue from file Apr 24 15:02:38 zero volumio[1537]: info: Setting Device type: Raspberry PI Apr 24 15:02:38 zero volumio[1537]: info: CoreStateMachine::setRepeat false single undefined Apr 24 15:02:38 zero volumio[1537]: info: CoreStateMachine::pushState Apr 24 15:02:38 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:38 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 15:02:38 zero volumio[1537]: info: CoreCommandRouter::volumioPushState Apr 24 15:02:38 zero volumio[1537]: info: CoreStateMachine::setRandom true Apr 24 15:02:38 zero volumio[1537]: info: CoreStateMachine::pushState Apr 24 15:02:38 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:38 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 15:02:38 zero volumio[1537]: info: CoreCommandRouter::volumioPushState Apr 24 15:02:38 zero systemd[1]: vtcs.service: Succeeded. Apr 24 15:02:38 zero volumio[1537]: info: VolumeController:: Volume=64 Mute =false Apr 24 15:02:38 zero volumio[1537]: info: CoreStateMachine::pushState Apr 24 15:02:38 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:38 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 15:02:38 zero volumio[1537]: info: CoreCommandRouter::volumioPushState Apr 24 15:02:38 zero volumio[1537]: info: CoreStateMachine::updateTrackBlock Apr 24 15:02:38 zero volumio[1537]: info: CorePlayQueue::getTrackBlock Apr 24 15:02:38 zero volumio[1537]: info: CoreCommandRouter::volumioRetrievevolume Apr 24 15:02:38 zero volumio[1537]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Apr 24 15:02:38 zero volumio[1537]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Apr 24 15:02:38 zero volumio[1537]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Apr 24 15:02:38 zero systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Apr 24 15:02:38 zero systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 5. Apr 24 15:02:38 zero systemd[1]: Stopped Volumio Tidal Connect Service. Apr 24 15:02:38 zero sudo[1751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 24 15:02:38 zero sudo[1751]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:38 zero systemd[1]: Started Volumio Tidal Connect Service. Apr 24 15:02:38 zero volumio[1537]: info: Completed loading Core Plugins Apr 24 15:02:38 zero volumio[1537]: info: Preparing to generate the ALSA configuration file Apr 24 15:02:38 zero volumio[1537]: info: Discovery: adding 9f8d5a4a-6806-46fe-b062-8e8decea0002 Apr 24 15:02:38 zero volumio[1537]: info: Discovery: Found device Zero Apr 24 15:02:38 zero volumio[1537]: info: CoreCommandRouter::volumioGetState Apr 24 15:02:38 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:38 zero volumio[1537]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 24 15:02:38 zero volumio[1537]: info: Reading ALSA contributions from plugins. Apr 24 15:02:38 zero volumio[1537]: info: VolumeController:: Volume=64 Mute =false Apr 24 15:02:38 zero volumio[1537]: info: CoreStateMachine::pushState Apr 24 15:02:38 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:38 zero volumio[1537]: info: CoreCommandRouter::volumioPushState Apr 24 15:02:38 zero volumio[1537]: info: Asound.conf file written Apr 24 15:02:38 zero sudo[1751]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:38 zero sudo[1756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 24 15:02:38 zero sudo[1756]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:39 zero sudo[1756]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:39 zero volumio[1537]: info: Output device has changed, restarting MPD Apr 24 15:02:39 zero sudo[1761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 24 15:02:39 zero sudo[1761]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:39 zero volumio[1537]: info: Output device has changed, restarting Shairport Sync Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:02:39 zero sudo[1761]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:39 zero sudo[1764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 24 15:02:39 zero sudo[1764]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:39 zero systemd[1]: Stopping Music Player Daemon... Apr 24 15:02:39 zero volumio[1537]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 15:02:39 zero volumio[1537]: info: ___________ START PLUGINS ___________ Apr 24 15:02:39 zero volumio[1537]: info: ControllerMpd::onStart: Initializing MPD Apr 24 15:02:39 zero volumio[1537]: info: Creating MPD Configuration file Apr 24 15:02:39 zero sudo[1770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 24 15:02:39 zero sudo[1770]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:39 zero sudo[1770]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:02:39 zero volumio[1537]: info: [1745524959664] CoreMusicLibrary::Adding element Media Servers Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:02:39 zero sudo[1773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 24 15:02:39 zero sudo[1773]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:02:39 zero volumio[1537]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:02:39 zero volumio[1537]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:02:39 zero volumio[1537]: info: [1745524959886] CoreMusicLibrary::Adding element Last_100 Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:02:39 zero volumio[1537]: info: [1745524959892] CoreMusicLibrary::Adding element Webradio Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 24 15:02:39 zero volumio[1537]: info: Initializing BBC Radios Apr 24 15:02:39 zero volumio[1537]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Apr 24 15:02:39 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:02:40 zero volumio[1537]: info: Adding Calm Radio to Browse Sources Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:02:40 zero volumio[1537]: info: [1745524960050] CoreMusicLibrary::Adding element Calm Radio Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:02:40 zero volumio[1537]: Cannot find translation for source Calm Radio Apr 24 15:02:40 zero volumio[1537]: info: Creating Spotify config file Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:02:40 zero volumio[1537]: info: [1745524960109] CoreMusicLibrary::Adding element YouTube2 Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:02:40 zero volumio[1537]: Cannot find translation for source Calm Radio Apr 24 15:02:40 zero volumio[1537]: Cannot find translation for source YouTube2 Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:02:40 zero volumio[1537]: info: [1745524960197] CoreMusicLibrary::Adding element YouTube Music Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:02:40 zero volumio[1537]: Cannot find translation for source Calm Radio Apr 24 15:02:40 zero volumio[1537]: Cannot find translation for source YouTube2 Apr 24 15:02:40 zero volumio[1537]: Cannot find translation for source YouTube Music Apr 24 15:02:40 zero volumio[1537]: info: Loading i18n strings for locale es Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:40 zero volumio[1537]: info: FusionDsp - mixtype--------------------- Hardware Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 15:02:40 zero volumio[1537]: info: [1745524960238] CoreMusicLibrary::Adding element 80s80s Radio Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:02:40 zero volumio[1537]: Cannot find translation for source Calm Radio Apr 24 15:02:40 zero volumio[1537]: Cannot find translation for source YouTube2 Apr 24 15:02:40 zero volumio[1537]: Cannot find translation for source YouTube Music Apr 24 15:02:40 zero volumio[1537]: Cannot find translation for source 80s80s Radio Apr 24 15:02:40 zero volumio[1537]: info: Volumio Calling Home Apr 24 15:02:40 zero volumio[1537]: info: Preparing to generate the ALSA configuration file Apr 24 15:02:40 zero volumio[1537]: verbose: [yt-cast-receiver] Setting app pid to stored value: 0790e94f-2a47-4c4e-8911-b2505d7af98b Apr 24 15:02:40 zero volumio[1537]: verbose: [yt-cast-receiver] Starting YouTubeApp... Apr 24 15:02:40 zero volumio[1537]: verbose: [yt-cast-receiver] (YouTube) Configuring session with stored MDX context: Apr 24 15:02:40 zero volumio[1537]: { Apr 24 15:02:40 zero volumio[1537]: deviceId: 'b09c8eaa-61a9-47d1-8655-fee1bad2fba5', Apr 24 15:02:40 zero volumio[1537]: screenId: '79t767efofk6v1tep43qs0h93s' Apr 24 15:02:40 zero volumio[1537]: } Apr 24 15:02:40 zero volumio[1537]: verbose: [yt-cast-receiver] (YouTube Music) Configuring session with stored MDX context: Apr 24 15:02:40 zero volumio[1537]: { Apr 24 15:02:40 zero volumio[1537]: deviceId: 'd23b40c7-a779-4ac5-8fa3-143b46148b7c', Apr 24 15:02:40 zero volumio[1537]: screenId: 'qbs9eq2sphvv2o0lhh0c2f1dpp' Apr 24 15:02:40 zero volumio[1537]: } Apr 24 15:02:40 zero volumio[1537]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 24 15:02:40 zero volumio[1537]: info: Reading ALSA contributions from plugins. Apr 24 15:02:40 zero volumio[1537]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 8 Apr 24 15:02:40 zero volumio[1537]: info: MPD Permissions set Apr 24 15:02:40 zero volumio[1537]: info: MPD Permissions set Apr 24 15:02:40 zero volumio[1537]: info: Upmpdcli Daemon Started Apr 24 15:02:40 zero volumio[1537]: info: No valid Plugin REST Endpoint Apr 24 15:02:40 zero vtcs[1750]: BYE TidalConnect Apr 24 15:02:40 zero volumio[1537]: info: Spotify config file written Apr 24 15:02:40 zero systemd[1]: vtcs.service: Succeeded. Apr 24 15:02:40 zero volumio[1537]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:40 zero systemd[1]: mpd.service: Succeeded. Apr 24 15:02:40 zero systemd[1]: Stopped Music Player Daemon. Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:40 zero sudo[1796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 24 15:02:40 zero sudo[1796]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:40 zero systemd[1]: Starting Music Player Daemon... Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:02:40 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:40 zero volumio[1537]: info: No need to fix Spotify hosts Apr 24 15:02:40 zero systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Apr 24 15:02:40 zero systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 6. Apr 24 15:02:40 zero systemd[1]: Stopping go-librespot Daemon... Apr 24 15:02:40 zero systemd[1]: Stopped Volumio Tidal Connect Service. Apr 24 15:02:40 zero systemd[1]: Started Volumio Tidal Connect Service. Apr 24 15:02:40 zero systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Apr 24 15:02:40 zero systemd[1]: go-librespot-daemon.service: Succeeded. Apr 24 15:02:40 zero systemd[1]: Stopped go-librespot Daemon. Apr 24 15:02:40 zero systemd[1]: Started go-librespot Daemon. Apr 24 15:02:40 zero sudo[1796]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:41 zero go-librespot[1809]: go-librespot daemon starting... Apr 24 15:02:41 zero volumio[1537]: info: Volumio called home Apr 24 15:02:41 zero volumio[1537]: info: CoreCommandRouter::volumioGetState Apr 24 15:02:41 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:41 zero volumio[1537]: info: Starting Shairport Sync Apr 24 15:02:41 zero volumio[1537]: info: Starting Shairport Sync Apr 24 15:02:41 zero sudo[1814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 24 15:02:41 zero volumio[1537]: info: Starting Shairport Sync Apr 24 15:02:41 zero sudo[1814]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:41 zero sudo[1797]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 24 15:02:41 zero sudo[1797]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:41 zero sudo[1818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 24 15:02:41 zero sudo[1818]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:41 zero sudo[1797]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:41 zero sudo[1825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 24 15:02:41 zero sudo[1825]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:41 zero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 24 15:02:41 zero volumio[1537]: info: Asound.conf file unchanged, so no further update is needed Apr 24 15:02:41 zero volumio[1537]: info: Output device has changed, restarting MPD Apr 24 15:02:41 zero volumio[1537]: info: Output device has changed, restarting Shairport Sync Apr 24 15:02:41 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:41 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:02:41 zero go-librespot[1809]: time="2025-04-24T15:02:41-05:00" level=info msg="running go-librespot 0.2.0" Apr 24 15:02:41 zero go-librespot[1809]: time="2025-04-24T15:02:41-05:00" level=debug msg="app state loaded" Apr 24 15:02:41 zero volumio[1537]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 15:02:41 zero go-librespot[1809]: time="2025-04-24T15:02:41-05:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 24 15:02:41 zero sudo[1831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 24 15:02:41 zero sudo[1831]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:41 zero sudo[1828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 24 15:02:41 zero sudo[1828]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:41 zero ntpd[680]: Soliciting pool server 2001:12ff:0:7::186 Apr 24 15:02:41 zero sudo[1828]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:41 zero systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 24 15:02:41 zero systemd[1]: mpd.service: Succeeded. Apr 24 15:02:41 zero systemd[1]: Stopped Music Player Daemon. Apr 24 15:02:41 zero volumio[1537]: info: MPD Permissions set Apr 24 15:02:41 zero volumio[1537]: info: No valid Plugin REST Endpoint Apr 24 15:02:41 zero vtcs[1807]: BYE TidalConnect Apr 24 15:02:41 zero systemd[1]: Starting Music Player Daemon... Apr 24 15:02:41 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:41 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:41 zero systemd[1]: shairport-sync.service: Succeeded. Apr 24 15:02:41 zero systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 24 15:02:41 zero systemd[1]: vtcs.service: Succeeded. Apr 24 15:02:41 zero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 24 15:02:41 zero sudo[1818]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:41 zero sudo[1814]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:41 zero sudo[1825]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:41 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 15:02:41 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:41 zero volumio[1537]: info: Shairport-Sync Started Apr 24 15:02:41 zero volumio[1537]: Error adding Membership: Error: addMembership EINVAL Apr 24 15:02:41 zero volumio[1537]: info: Shairport-Sync Started Apr 24 15:02:41 zero volumio[1537]: info: Starting Shairport Sync Apr 24 15:02:41 zero sudo[1837]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 24 15:02:41 zero sudo[1837]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:41 zero sudo[1837]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:42 zero volumio[1537]: verbose: [yt-cast-receiver] (YouTube) Obtained lounge token: Apr 24 15:02:42 zero volumio[1537]: { Apr 24 15:02:42 zero volumio[1537]: screenId: '79t767efofk6v1tep43qs0h93s', Apr 24 15:02:42 zero volumio[1537]: refreshIntervalInMillis: 1123200000, Apr 24 15:02:42 zero volumio[1537]: remoteRefreshIntervalMs: 79200000, Apr 24 15:02:42 zero volumio[1537]: refreshIntervalMs: 1123200000, Apr 24 15:02:42 zero volumio[1537]: loungeTokenLifespanMs: 1209600000, Apr 24 15:02:42 zero volumio[1537]: loungeToken: 'AGdO5p8mloJ_2tn1h20cEGEc9SRo_m6gRaiA4pvi9O0j5v-onM1qWTcmvLGObW2KfH1YwqrVaY8RJtpVkAPJtKLaeFjdWMJKLBfnlNdmf5YeMNmRktBD5xw', Apr 24 15:02:42 zero volumio[1537]: remoteRefreshIntervalInMillis: 79200000, Apr 24 15:02:42 zero volumio[1537]: expiration: 1746648161393 Apr 24 15:02:42 zero volumio[1537]: } Apr 24 15:02:42 zero sudo[1848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 24 15:02:42 zero sudo[1848]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:42 zero systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Apr 24 15:02:42 zero systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 7. Apr 24 15:02:42 zero volumio[1537]: verbose: [yt-cast-receiver] (YouTube Music) Obtained lounge token: Apr 24 15:02:42 zero volumio[1537]: { Apr 24 15:02:42 zero volumio[1537]: screenId: 'qbs9eq2sphvv2o0lhh0c2f1dpp', Apr 24 15:02:42 zero volumio[1537]: refreshIntervalInMillis: 1123200000, Apr 24 15:02:42 zero volumio[1537]: remoteRefreshIntervalMs: 79200000, Apr 24 15:02:42 zero volumio[1537]: refreshIntervalMs: 1123200000, Apr 24 15:02:42 zero volumio[1537]: loungeTokenLifespanMs: 1209600000, Apr 24 15:02:42 zero volumio[1537]: loungeToken: 'AGdO5p_nfa1GIouSvHS3U17AYFV1VulmrP8yEqTK1MqGDW0dBummpFxapnZYQQ8uRm3SZibv3bJZKhOHgcVWdxejbSRhaAOeEoijc9Gs17Ie0UyMkfkM-hc', Apr 24 15:02:42 zero volumio[1537]: remoteRefreshIntervalInMillis: 79200000, Apr 24 15:02:42 zero volumio[1537]: expiration: 1746648161360 Apr 24 15:02:42 zero volumio[1537]: } Apr 24 15:02:42 zero systemd[1]: Stopped Volumio Tidal Connect Service. Apr 24 15:02:42 zero systemd[1]: Started Volumio Tidal Connect Service. Apr 24 15:02:42 zero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 24 15:02:42 zero systemd[1]: shairport-sync.service: Succeeded. Apr 24 15:02:42 zero systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 24 15:02:42 zero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 24 15:02:42 zero sudo[1848]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:42 zero go-librespot[1809]: time="2025-04-24T15:02:42-05:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 24 15:02:42 zero go-librespot[1809]: time="2025-04-24T15:02:42-05:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 24 15:02:42 zero go-librespot[1809]: time="2025-04-24T15:02:42-05:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 24 15:02:42 zero go-librespot[1809]: time="2025-04-24T15:02:42-05:00" level=info msg="zeroconf server listening on port 34109" Apr 24 15:02:42 zero volumio[1537]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 24 15:02:42 zero volumio[1537]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Apr 24 15:02:42 zero volumio[1537]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 24 15:02:42 zero volumio[1537]: info: camilladsp spawned new process with pid 1877, instance 1, run: true Apr 24 15:02:42 zero volumio[1537]: info: camilladsp service started and running in background, instance 1 Apr 24 15:02:42 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 15:02:42 zero volumio[1537]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 <-AAAAAAAAAAAAA Apr 24 15:02:42 zero volumio[1537]: info: FusionDsp loaded Apr 24 15:02:42 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 24 15:02:42 zero volumio[1537]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 24 15:02:42 zero volumio[1537]: info: Adding Signal Path Element [object Object] Apr 24 15:02:42 zero volumio[1537]: info: Adding fusiondspeq DSP Signal Path Element Apr 24 15:02:42 zero volumio[1537]: info: FusionDsp - ---- installed callbackRead Apr 24 15:02:42 zero volumio[1537]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 24 15:02:42 zero sudo[1888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 24 15:02:42 zero sudo[1888]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 15:02:42 zero volumio[1537]: info: Shairport-Sync Started Apr 24 15:02:42 zero volumio[1537]: info: No valid Plugin REST Endpoint Apr 24 15:02:42 zero vtcs[1851]: BYE TidalConnect Apr 24 15:02:42 zero volumio[1537]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Apr 24 15:02:42 zero sudo[1888]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:42 zero volumio[1537]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 24 15:02:42 zero systemd[1]: vtcs.service: Succeeded. Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (YouTube) Received messages for establishing session: Apr 24 15:02:43 zero volumio[1537]: [ Apr 24 15:02:43 zero volumio[1537]: Message { AID: 0, name: 'c', payload: [ 'B1914BF96C3A733', '', 8 ] }, Apr 24 15:02:43 zero volumio[1537]: Message { Apr 24 15:02:43 zero volumio[1537]: AID: 1, Apr 24 15:02:43 zero volumio[1537]: name: 'S', Apr 24 15:02:43 zero volumio[1537]: payload: '2W2iYrIck561bRMWAs0IpXYPhs8BEpWaf-BQ4CZ9uNs' Apr 24 15:02:43 zero volumio[1537]: }, Apr 24 15:02:43 zero volumio[1537]: Message { Apr 24 15:02:43 zero volumio[1537]: AID: 2, Apr 24 15:02:43 zero volumio[1537]: name: 'loungeStatus', Apr 24 15:02:43 zero volumio[1537]: payload: { Apr 24 15:02:43 zero volumio[1537]: queueId: 'RQR8EZggreRSv15-jwERRqi2Kli9o', Apr 24 15:02:43 zero volumio[1537]: devices: '[{"app":"ytcr","capabilities":"dsp,mic,dpa,ntb,que,mus","clientName":"unknown","experiments":"","name":"YouTube on Zero","theme":"cl","id":"b09c8eaa-61a9-47d1-8655-fee1bad2fba5","type":"LOUNGE_SCREEN","hasCc":"true","deviceInfo":"{\\"year\\":0,\\"os\\":\\"Windows\\",\\"osVersion\\":\\"10.0\\",\\"chipset\\":\\"\\",\\"clientName\\":\\"TVHTML5\\",\\"dialAdditionalDataSupportLevel\\":\\"unsupported\\",\\"mdxDialServerType\\":\\"MDX_DIAL_SERVER_TYPE_UNKNOWN\\",\\"brand\\":\\"Generic\\",\\"model\\":\\"SmartTV\\"}","receiverIdentityMatchStatus":"IS_RECEIVER"}]', Apr 24 15:02:43 zero volumio[1537]: connectionEventDetails: '{"deviceId":"b09c8eaa-61a9-47d1-8655-fee1bad2fba5"}' Apr 24 15:02:43 zero volumio[1537]: } Apr 24 15:02:43 zero volumio[1537]: }, Apr 24 15:02:43 zero volumio[1537]: Message { AID: 3, name: 'getNowPlaying', payload: {} }, Apr 24 15:02:43 zero volumio[1537]: Message { AID: 4, name: 'getDiscoveryDeviceId', payload: {} } Apr 24 15:02:43 zero volumio[1537]: ] Apr 24 15:02:43 zero volumio[1537]: verbose: ----------------------------------- Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (AID: 2) (YouTube) Incoming message: 'loungeStatus' Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] Connecting to RPC URL: https://www.youtube.com/api/lounge/bc/bind?AID=3&CI=0&RID=rpc&SID=B1914BF96C3A733&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=2W2iYrIck561bRMWAs0IpXYPhs8BEpWaf-BQ4CZ9uNs&id=b09c8eaa-61a9-47d1-8655-fee1bad2fba5&loungeIdToken=AGdO5p8mloJ_2tn1h20cEGEc9SRo_m6gRaiA4pvi9O0j5v-onM1qWTcmvLGObW2KfH1YwqrVaY8RJtpVkAPJtKLaeFjdWMJKLBfnlNdmf5YeMNmRktBD5xw&mdxVersion=2&name=YouTube%20on%20Zero&obfuscatedGaiaId=&t=1&theme=cl&v=2&zx=5b5672626b98 Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (YouTube Music) Received messages for establishing session: Apr 24 15:02:43 zero volumio[1537]: [ Apr 24 15:02:43 zero volumio[1537]: Message { AID: 0, name: 'c', payload: [ 'A1B22DE4F566F108', '', 8 ] }, Apr 24 15:02:43 zero volumio[1537]: Message { Apr 24 15:02:43 zero volumio[1537]: AID: 1, Apr 24 15:02:43 zero volumio[1537]: name: 'S', Apr 24 15:02:43 zero volumio[1537]: payload: 'FjxQYGmR9tEcNmv-kLwyWANmBKEqkIjJT5asdHa5BII' Apr 24 15:02:43 zero volumio[1537]: }, Apr 24 15:02:43 zero volumio[1537]: Message { Apr 24 15:02:43 zero volumio[1537]: AID: 2, Apr 24 15:02:43 zero volumio[1537]: name: 'loungeStatus', Apr 24 15:02:43 zero volumio[1537]: payload: { Apr 24 15:02:43 zero volumio[1537]: queueId: 'RQXxWmWdT3hSYcXUO_KEcsVq8KNII', Apr 24 15:02:43 zero volumio[1537]: devices: '[{"app":"ytcr","capabilities":"dsp,mic,dpa,ntb","clientName":"unknown","experiments":"","name":"YouTube on Zero","theme":"m","id":"d23b40c7-a779-4ac5-8fa3-143b46148b7c","type":"LOUNGE_SCREEN","hasCc":"true","deviceInfo":"{\\"year\\":0,\\"os\\":\\"Windows\\",\\"osVersion\\":\\"10.0\\",\\"chipset\\":\\"\\",\\"clientName\\":\\"TVHTML5\\",\\"dialAdditionalDataSupportLevel\\":\\"unsupported\\",\\"mdxDialServerType\\":\\"MDX_DIAL_SERVER_TYPE_UNKNOWN\\",\\"brand\\":\\"Generic\\",\\"model\\":\\"SmartTV\\"}","receiverIdentityMatchStatus":"IS_RECEIVER"}]', Apr 24 15:02:43 zero volumio[1537]: connectionEventDetails: '{"deviceId":"d23b40c7-a779-4ac5-8fa3-143b46148b7c"}' Apr 24 15:02:43 zero volumio[1537]: } Apr 24 15:02:43 zero volumio[1537]: }, Apr 24 15:02:43 zero volumio[1537]: Message { AID: 3, name: 'getNowPlaying', payload: {} }, Apr 24 15:02:43 zero volumio[1537]: Message { AID: 4, name: 'getDiscoveryDeviceId', payload: {} } Apr 24 15:02:43 zero volumio[1537]: ] Apr 24 15:02:43 zero volumio[1537]: verbose: ----------------------------------- Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (AID: 2) (YouTube Music) Incoming message: 'loungeStatus' Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] Connecting to RPC URL: https://www.youtube.com/api/lounge/bc/bind?AID=3&CI=0&RID=rpc&SID=A1B22DE4F566F108&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=FjxQYGmR9tEcNmv-kLwyWANmBKEqkIjJT5asdHa5BII&id=d23b40c7-a779-4ac5-8fa3-143b46148b7c&loungeIdToken=AGdO5p_nfa1GIouSvHS3U17AYFV1VulmrP8yEqTK1MqGDW0dBummpFxapnZYQQ8uRm3SZibv3bJZKhOHgcVWdxejbSRhaAOeEoijc9Gs17Ie0UyMkfkM-hc&mdxVersion=2&name=YouTube%20on%20Zero&obfuscatedGaiaId=&t=1&theme=m&v=2&zx=3e0af22102fd Apr 24 15:02:43 zero systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Apr 24 15:02:43 zero systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 8. Apr 24 15:02:43 zero systemd[1]: Stopped Volumio Tidal Connect Service. Apr 24 15:02:43 zero systemd[1]: Started Volumio Tidal Connect Service. Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] RPC connection established. Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (YouTube) Session established. Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (YouTube) Saving MDX context to data store: Apr 24 15:02:43 zero volumio[1537]: { Apr 24 15:02:43 zero volumio[1537]: deviceId: 'b09c8eaa-61a9-47d1-8655-fee1bad2fba5', Apr 24 15:02:43 zero volumio[1537]: screenId: '79t767efofk6v1tep43qs0h93s' Apr 24 15:02:43 zero volumio[1537]: } Apr 24 15:02:43 zero volumio[1537]: verbose: ----------------------------------- Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (AID: 4) (YouTube) Incoming message: 'getDiscoveryDeviceId' Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (AID: 4) (YouTube) Not handled: 'getDiscoveryDeviceId' Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] RPC connection established. Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (YouTube Music) Session established. Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (YouTube Music) Saving MDX context to data store: Apr 24 15:02:43 zero volumio[1537]: { Apr 24 15:02:43 zero volumio[1537]: deviceId: 'd23b40c7-a779-4ac5-8fa3-143b46148b7c', Apr 24 15:02:43 zero volumio[1537]: screenId: 'qbs9eq2sphvv2o0lhh0c2f1dpp' Apr 24 15:02:43 zero volumio[1537]: } Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] Starting DIAL server... Apr 24 15:02:43 zero volumio[1537]: info: [yt-cast-receiver] DIAL server listening on port 8098 Apr 24 15:02:43 zero volumio[1537]: info: CoreCommandRouter::volumioRetrievevolume Apr 24 15:02:43 zero volumio[1537]: verbose: ----------------------------------- Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (AID: 4) (YouTube Music) Incoming message: 'getDiscoveryDeviceId' Apr 24 15:02:43 zero volumio[1537]: verbose: [yt-cast-receiver] (AID: 4) (YouTube Music) Not handled: 'getDiscoveryDeviceId' Apr 24 15:02:43 zero volumio[1537]: info: VolumeController:: Volume=64 Mute =false Apr 24 15:02:43 zero volumio[1537]: info: CoreCommandRouter::volumioGetState Apr 24 15:02:43 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:43 zero volumio[1537]: info: CoreStateMachine::pushState Apr 24 15:02:43 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:43 zero volumio[1537]: info: CoreCommandRouter::volumioPushState Apr 24 15:02:43 zero volumio[1537]: verbose: [ytcr] VolumeControl initialized with current volume: Apr 24 15:02:43 zero volumio[1537]: { level: 64, muted: false } Apr 24 15:02:44 zero volumio[1537]: info: go-librespot daemon successfully initialized Apr 24 15:02:44 zero volumio[1537]: info: No valid Plugin REST Endpoint Apr 24 15:02:44 zero vtcs[1891]: BYE TidalConnect Apr 24 15:02:44 zero systemd[1]: vtcs.service: Succeeded. Apr 24 15:02:44 zero volumio[1537]: verbose: New Socket.io Connection to 192.168.200.101 from 192.168.200.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 11 Apr 24 15:02:44 zero systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Apr 24 15:02:44 zero systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 9. Apr 24 15:02:44 zero systemd[1]: Stopped Volumio Tidal Connect Service. Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 24 15:02:44 zero systemd[1]: Started Volumio Tidal Connect Service. Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::volumioGetVisibleSources Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::volumioGetState Apr 24 15:02:44 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::volumioGetState Apr 24 15:02:44 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 24 15:02:44 zero volumio[1537]: info: Received Get System Info Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 24 15:02:44 zero volumio[1537]: info: Discovery: Getting this device information Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::volumioGetState Apr 24 15:02:44 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::volumioGetState Apr 24 15:02:44 zero volumio[1537]: info: CorePlayQueue::getTrack 0 Apr 24 15:02:44 zero volumio[1537]: info: Listing playlists Apr 24 15:02:44 zero volumio[1537]: info: CoreCommandRouter::volumioGetQueue Apr 24 15:02:44 zero volumio[1537]: info: CoreStateMachine::getQueue Apr 24 15:02:44 zero volumio[1537]: info: CorePlayQueue::getQueue Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 15:02:45 zero volumio[1537]: info: No valid Plugin REST Endpoint Apr 24 15:02:45 zero vtcs[1896]: BYE TidalConnect Apr 24 15:02:45 zero systemd[1]: vtcs.service: Succeeded. Apr 24 15:02:45 zero systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Apr 24 15:02:45 zero systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 10. Apr 24 15:02:45 zero systemd[1]: Stopped Volumio Tidal Connect Service. Apr 24 15:02:45 zero systemd[1]: vtcs.service: Start request repeated too quickly. Apr 24 15:02:45 zero systemd[1]: vtcs.service: Failed with result 'start-limit-hit'. Apr 24 15:02:45 zero systemd[1]: Failed to start Volumio Tidal Connect Service. Apr 24 15:02:45 zero mpd[1847]: Apr 24 15:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 24 15:02:45 zero systemd[1]: Started Music Player Daemon. Apr 24 15:02:45 zero sudo[1773]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:45 zero sudo[1764]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:45 zero sudo[1831]: pam_unix(sudo:session): session closed for user root Apr 24 15:02:49 zero volumio[1537]: info: Initializing connection to go-librespot Websocket Apr 24 15:02:50 zero volumio[1537]: error: MPD error: The expression evaluated to a falsy value: Apr 24 15:02:50 zero volumio[1537]: assert.ok(self.idling) Apr 24 15:02:50 zero volumio[1537]: error: The expression evaluated to a falsy value: Apr 24 15:02:50 zero volumio[1537]: assert.ok(self.idling) Apr 24 15:02:50 zero volumio[1537]: error: MPD error: The expression evaluated to a falsy value: Apr 24 15:02:50 zero volumio[1537]: assert.ok(self.idling) Apr 24 15:02:50 zero volumio[1537]: error: The expression evaluated to a falsy value: Apr 24 15:02:50 zero volumio[1537]: assert.ok(self.idling) Apr 24 15:02:50 zero go-librespot[1809]: time="2025-04-24T15:02:50-05:00" level=debug msg="new websocket client" Apr 24 15:02:50 zero volumio[1537]: error: updateQueue error: null Apr 24 15:02:50 zero volumio[1537]: info: Connection to go-librespot Websocket established Apr 24 15:02:50 zero volumio[1537]: info: MPD running with PID1847 Apr 24 15:02:50 zero volumio[1537]: ,establishing connection Apr 24 15:02:50 zero volumio[1537]: error: updateQueue error: null Apr 24 15:02:50 zero volumio[1537]: verbose: [ytcr] MPD connected Apr 24 15:02:50 zero volumio[1537]: verbose: [ytcr] MPDSubsystemEventEmitter enabled. Apr 24 15:02:50 zero volumio[1537]: verbose: [ytcr] Receiver started with options: Apr 24 15:02:50 zero volumio[1537]: { Apr 24 15:02:50 zero volumio[1537]: dial: { port: 8098, bindToInterfaces: [ 'wlan0' ] }, Apr 24 15:02:50 zero volumio[1537]: app: { Apr 24 15:02:50 zero volumio[1537]: enableAutoplayOnConnect: true, Apr 24 15:02:50 zero volumio[1537]: resetPlayerOnDisconnectPolicy: 'allExplicitlyDisconnected' Apr 24 15:02:50 zero volumio[1537]: }, Apr 24 15:02:50 zero volumio[1537]: dataStore: ReceiverDataStore {}, Apr 24 15:02:50 zero volumio[1537]: logger: Logger { level: 'debug', color: true }, Apr 24 15:02:50 zero volumio[1537]: logLevel: 'debug', Apr 24 15:02:50 zero volumio[1537]: device: { name: 'Zero' } Apr 24 15:02:50 zero volumio[1537]: } Apr 24 15:02:50 zero volumio[1537]: info: Completed starting Core Plugins Apr 24 15:02:50 zero volumio[1537]: info: ------------------------------------------- Apr 24 15:02:50 zero volumio[1537]: info: ----- MyVolumio plugins startup ---- Apr 24 15:02:50 zero volumio[1537]: info: ------------------------------------------- Apr 24 15:02:50 zero volumio[1537]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 24 15:02:53 zero volumio[1537]: info: Preload queue cleared Apr 24 15:02:53 zero volumio[1537]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 15:02:53 zero volumio[1537]: info: CoreStateMachine::ClearQueue Apr 24 15:02:53 zero volumio[1537]: info: CoreStateMachine::stop Apr 24 15:02:53 zero volumio[1537]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 15:02:53 zero volumio[1537]: info: CorePlayQueue::clearPlayQueue Apr 24 15:02:53 zero volumio[1537]: info: CorePlayQueue::saveQueue Apr 24 15:02:53 zero volumio[1537]: info: CoreCommandRouter::volumioPushQueue Apr 24 15:02:53 zero volumio[1537]: info: CoreStateMachine::addQueueItems Apr 24 15:02:53 zero volumio[1537]: info: CorePlayQueue::addQueueItems Apr 24 15:02:53 zero volumio[1537]: info: Preload queue cleared Apr 24 15:02:53 zero volumio[1537]: info: Adding Item to queue: music-library/INTERNAL/Spotify 2/Oldies spotify Apr 24 15:02:53 zero volumio[1537]: info: Exploding uri music-library/INTERNAL/Spotify 2/Oldies spotify in service mpd Apr 24 15:02:53 zero volumio[1537]: info: Getting Spotify volume Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=John%20Lennon/Gimme%20Some%20Truth/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2F(Just%20Like)%20Starting%20Over%20-%20Remastered%202010.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/(Just Like) Starting Over - Remastered 2010.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=KC%20%26%20The%20Sunshine%20Band/Part%203/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2F(Shake%2C%20Shake%2C%20Shake)%20Shake%20Your%20Booty.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/(Shake, Shake, Shake) Shake Your Booty.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=George%20Harrison/Let%20It%20Roll%20-%20Songs%20Of%20George%20Harrison/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FAll%20Those%20Years%20Ago%20-%202009%20Mix.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/All Those Years Ago - 2009 Mix.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=The%20Beatles/The%20Beatles%20(Remastered)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FBack%20In%20The%20U.S.S.R.%20-%20Remastered%202009.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Back In The U.S.S.R. - Remastered 2009.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Gerry%20Rafferty/City%20to%20City/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FBaker%20Street.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Baker Street.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Paul%20McCartney%2FWings/Band%20On%20The%20Run/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FBand%20On%20The%20Run%20-%202010%20Remaster.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Band On The Run - 2010 Remaster.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Joey%20Scarbury/America's%20Greatest%20Hero/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FBelieve%20It%20or%20Not%20(Theme%20from%20_Greatest%20American%20Hero_).mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Believe It or Not (Theme from _Greatest American Hero_).mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=The%20Red%20One%20Rocketman/Benny%20and%20the%20Jets/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FBenny%20and%20the%20Jets.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Benny and the Jets.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Ambrosia/One%20Eighty/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FBiggest%20Part%20of%20Me.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Biggest Part of Me.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Steppenwolf/Steppenwolf/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FBorn%20To%20Be%20Wild.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Born To Be Wild.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Elton%20John/Diamonds%20(Deluxe)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FCandle%20In%20The%20Wind%20-%20Remastered.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Candle In The Wind - Remastered.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Paul%20Davis/Cool%20Night/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FCool%20Night.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Cool Night.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Orleans/Dance%20With%20Me%3A%20The%20Best%20Of%20Orleans/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FDance%20with%20Me.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Dance with Me.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Elton%20John/Don't%20Shoot%20Me%20I'm%20Only%20The%20Piano%20Player/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FDaniel.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Daniel.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=The%20Beatles/1%20(Remastered)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FDay%20Tripper%20-%20Remastered%202015.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Day Tripper - Remastered 2015.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Frankie%20Valli%20%26%20The%20Four%20Seasons/Who%20Loves%20You/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FDecember%2C%201963%20(Oh%20What%20a%20Night!).mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/December, 1963 (Oh What a Night!).mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Michael%20Jackson/Off%20the%20Wall/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FDon't%20Stop%20'Til%20You%20Get%20Enough.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Don't Stop 'Til You Get Enough.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Aerosmith/Aerosmith/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FDream%20On.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Dream On.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Rupert%20Holmes/'70s%20Pop%20%231's/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FEscape%20(The%20Pina%20Colada%20Song).mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Escape (The Pina Colada Song).mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=The%20J.%20Geils%20Band/Freeze%20Frame/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FFreeze-Frame.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Freeze-Frame.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=The%20Beatles%2FBilly%20Preston/1%20(Remastered)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FGet%20Back%20-%20Remastered%202015.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Get Back - Remastered 2015.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=The%20Beatles/Sgt.%20Pepper's%20Lonely%20Hearts%20Club%20Band%20(Remastered)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FGetting%20Better%20-%20Remastered%202009.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Getting Better - Remastered 2009.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Smash%20Mouth/All%20Star%20Smash%20Hits/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FGetting%20Better%20-%20The%20Cat%20In%20The%20Hat%2FSoundtrack%20Version.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Getting Better - The Cat In The Hat/Soundtrack Version.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=George%20Benson/The%20Best%20of%20George%20Benson/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FGive%20Me%20the%20Night%20-%20Edit.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Give Me the Night - Edit.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Supertramp/Breakfast%20In%20America%20(Deluxe%20Edition)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FGoodbye%20Stranger%20-%202010%20Remastered.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Goodbye Stranger - 2010 Remastered.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Jerry%20Lee%20Lewis/The%20Golden%20Rock%20Hits%20Of%20Jerry%20Lee%20Lewis/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FGreat%20Balls%20Of%20Fire%20-%201964%20Version.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Great Balls Of Fire - 1964 Version.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Jerry%20Lee%20Lewis/Great%20Balls%20Of%20Fire/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FGreat%20Balls%20Of%20Fire.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Great Balls Of Fire.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Bread/Guitar%20Man/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FGuitar%20Man.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Guitar Man.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=The%20Turtles/Happy%20Together/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FHappy%20Together.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Happy Together.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=The%20Beatles/Abbey%20Road%20(Remastered)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FHere%20Comes%20The%20Sun%20-%20Remastered%202009.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Here Comes The Sun - Remastered 2009.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Steely%20Dan/Gaucho/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FHey%20Nineteen.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Hey Nineteen.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Rupert%20Holmes/Throwback%20Tunes%3A%201980/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FHim.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Him.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Ace/Five-A-Side/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FHow%20Long.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/How Long.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Ambrosia/Life%20Beyond%20L.A./extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FHow%20Much%20I%20Feel.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/How Much I Feel.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Paul%20Davis/Singer%20of%20Songs%2C%20Teller%20of%20Tales/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FI%20Go%20Crazy.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/I Go Crazy.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Michael%20McDonald/If%20That's%20What%20It%20Takes/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FI%20Keep%20Forgettin'%20(Every%20Time%20You're%20Near).mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/I Keep Forgettin' (Every Time You're Near).mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=England%20Dan%20%26%20John%20Ford%20Coley/Nights%20Are%20Forever/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FI'd%20Really%20Love%20to%20See%20You%20Tonight.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/I'd Really Love to See You Tonight.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=10cc/The%20Original%20Soundtrack/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FI'm%20Not%20In%20Love.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/I'm Not In Love.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=The%20Beatles/Rubber%20Soul%20(Remastered%202009)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FIn%20My%20Life%20-%20Remastered%202009.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/In My Life - Remastered 2009.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=John%20Lennon/Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FJealous%20Guy%20-%20Remastered%202010.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Jealous Guy - Remastered 2010.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Bee%20Gees/Main%20Course/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FJive%20Talkin'.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Jive Talkin'.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Daryl%20Hall%20%26%20John%20Oates/Voices/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FKiss%20on%20My%20List.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Kiss on My List.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Electric%20Light%20Orchestra/A%20New%20World%20Record/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FLivin'%20Thing.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Livin' Thing.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Nicolette%20Larson/Nicolette/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FLotta%20Love.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Lotta Love.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Captain%20%26%20Tennille/Love%20Will%20Keep%20Us%20Together/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FLove%20Will%20Keep%20Us%20Together.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Love Will Keep Us Together.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Boz%20Scaggs/My%20Time%3A%20A%20Boz%20Scaggs%20Anthology%20(1969-1997)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FLowdown.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Lowdown.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Leo%20Sayer/Living%20In%20A%20Fantasy/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FMore%20Than%20I%20Can%20Say%20-%20Remastered.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/More Than I Can Say - Remastered.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Electric%20Light%20Orchestra/Out%20of%20the%20Blue/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FMr.%20Blue%20Sky.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Mr. Blue Sky.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Billy%20Joel/52nd%20Street/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FMy%20Life.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/My Life.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Eagles/Hotel%20California%20(2013%20Remaster)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FNew%20Kid%20in%20Town%20-%202013%20Remaster.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/New Kid in Town - 2013 Remaster.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Stephen%20Bishop/Careless/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FOn%20And%20On.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/On And On.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Daryl%20Hall%20%26%20John%20Oates/Private%20Eyes%20(Expanded%20Edition)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FPrivate%20Eyes.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Private Eyes.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=B.J.%20Thomas/Raindrops%20Keep%20Fallin'%20On%20My%20Head/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FRaindrops%20Keep%20Fallin'%20On%20My%20Head.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Raindrops Keep Fallin' On My Head.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Little%20River%20Band/Sleeper%20Catcher%20(Remastered)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FReminiscing%20-%20Remastered.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Reminiscing - Remastered.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Christopher%20Cross/Christopher%20Cross/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FRide%20Like%20the%20Wind.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Ride Like the Wind.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Gerry%20Rafferty/City%20to%20City/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FRight%20Down%20the%20Line.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Right Down the Line.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Elton%20John/Honky%20Chateau/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FRocket%20Man%20(I%20Think%20It's%20Going%20To%20Be%20A%20Long%2C%20Long%20Time).mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Rocket Man (I Think It's Going To Be A Long, Long Time).mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Steve%20Forbert/Jack%20Rabbit%20Slim/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FRomeo's%20Tune.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Romeo's Tune.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=TOTO/Toto%20IV/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FRosanna.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Rosanna.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Christopher%20Cross/Christopher%20Cross/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FSailing.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Sailing.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Scott%20McKenzie/The%20Graduate%20-%20Music%20From%20The%20Broadway%20Comedy/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FSan%20Francisco%20(Be%20Sure%20to%20Wear%20Flowers%20in%20Your%20Hair).mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/San Francisco (Be Sure to Wear Flowers in Your Hair).mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Daryl%20Hall%20%26%20John%20Oates/Daryl%20Hall%20%26%20John%20Oates%20(The%20Silver%20Album)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FSara%20Smile.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Sara Smile.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Bob%20Welch/French%20Kiss/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FSentimental%20Lady.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Sentimental Lady.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Dr.%20Hook/Completely%20Hooked/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FSexy%20Eyes%20-%20Single%20Version.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Sexy Eyes - Single Version.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Dr.%20Hook/Pleasure%20%26%20Pain/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FSharing%20The%20Night%20Together.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Sharing The Night Together.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Daryl%20Hall%20%26%20John%20Oates/Abandoned%20Luncheonette/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FShe's%20Gone.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/She's Gone.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Wings/Wings%20At%20The%20Speed%20Of%20Sound%20(Archive%20Collection)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FSilly%20Love%20Songs%20-%202014%20Remaster.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Silly Love Songs - 2014 Remaster.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=America/Hearts/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FSister%20Golden%20Hair.mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Sister Golden Hair.mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=The%20Hit%20Co.%2F%20The%20Tribute%20Co.%2FThe%20Hit%20Co./Best%20of%20the%20Beatles%20Box%20Set%20Vol.%202/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FSomething%20(In%20the%20Way%20She%20Moves).mp3&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/Something (In the Way She Moves).mp3 Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=Rupert%20Holmes/'70s%20Pop%20%231's/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FSpotiDownloader.com%20-%20Oldies.zip&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/SpotiDownloader.com - Oldies.zip Apr 24 15:02:53 zero volumio[1537]: info: ALBUMART /albumart?cacheid=381&web=The%20Beatles/1%20(Remastered)/extralarge&path=%2Fmnt%2FINTERNAL%2FSpotify%202%2FOldies%20spotify%2FSpotiDownloader.com%20-%20Oldies.zip&metadata=false Apr 24 15:02:53 zero volumio[1537]: info: URI /mnt/INTERNAL/Spotify 2/Oldies spotify/SpotiDownloader.com - Oldies.zip Apr 24 15:02:53 zero volumio[1537]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 15:02:53 zero volumio[1537]: Error: Unable to resolve or reject the same promise twice Apr 24 15:02:53 zero volumio[1537]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 24 15:02:53 zero volumio[1537]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21 Apr 24 15:02:53 zero volumio[1537]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 24 15:02:53 zero volumio[1537]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 24 15:02:53 zero volumio[1537]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 24 15:02:53 zero volumio[1537]: at Socket.emit (events.js:315:20) Apr 24 15:02:53 zero volumio[1537]: at addChunk (internal/streams/readable.js:309:12) Apr 24 15:02:53 zero volumio[1537]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 24 15:02:53 zero volumio[1537]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 24 15:02:53 zero volumio[1537]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 24 15:02:53 zero volumio[1537]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 15:02:55 zero sudo[1931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-24 15:01 Apr 24 15:02:55 zero sudo[1931]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"