-- Logs begin at Mon 2025-06-02 12:30:10 CEST, end at Mon 2025-06-02 12:33:38 CEST. -- Jun 02 12:32:20 volumio-zero-buero ntpd[442]: receive: Unexpected origin timestamp 0xebe7fc19.14dd3e49 does not match aorg 0000000000.00000000 from server@141.144.246.224 xmt 0xebe7fc34.60161b8e Jun 02 12:32:20 volumio-zero-buero ntpd[442]: receive: Unexpected origin timestamp 0xebe7fc19.14d1923f does not match aorg 0000000000.00000000 from server@185.255.121.15 xmt 0xebe7fc34.608e5f1a Jun 02 12:32:20 volumio-zero-buero ntpd[442]: receive: Unexpected origin timestamp 0xebe7fc19.14adb1a4 does not match aorg 0000000000.00000000 from server@129.70.132.34 xmt 0xebe7fc34.614daaba Jun 02 12:32:20 volumio-zero-buero ntpd[442]: receive: Unexpected origin timestamp 0xebe7fc19.14c5d637 does not match aorg 0000000000.00000000 from server@194.164.164.175 xmt 0xebe7fc34.648c1bd4 Jun 02 12:32:20 volumio-zero-buero volumio[703]: Forking 1 albumart workers Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::initPlayerControls Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 12:32:21 volumio-zero-buero volumio[703]: Express server listening on port 3000 Jun 02 12:32:21 volumio-zero-buero volumio[703]: [Metrics] WebUI: 38s 473.87ms Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreStateMachine::resetVolumioState Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreStateMachine::getcurrentVolume Jun 02 12:32:21 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 12:32:22 volumio-zero-buero volumio[703]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds Jun 02 12:32:22 volumio-zero-buero volumio[703]: info: MPD Permissions set Jun 02 12:32:23 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Total Clients: 1 Jun 02 12:32:23 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Total Clients: 2 Jun 02 12:32:24 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Total Clients: 3 Jun 02 12:32:24 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Total Clients: 4 Jun 02 12:32:24 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Total Clients: 5 Jun 02 12:32:24 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46:3000 from 192.168.178.29 UA: node-XMLHttpRequest Total Clients: 6 Jun 02 12:32:24 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46:3000 from 192.168.178.37 UA: node-XMLHttpRequest Total Clients: 7 Jun 02 12:32:24 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Total Clients: 8 Jun 02 12:32:24 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46:3000 from 192.168.178.29 UA: node-XMLHttpRequest Total Clients: 9 Jun 02 12:32:24 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46:3000 from 192.168.178.37 UA: node-XMLHttpRequest Total Clients: 10 Jun 02 12:32:24 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46:3000 from 192.168.178.29 UA: node-XMLHttpRequest Total Clients: 11 Jun 02 12:32:24 volumio-zero-buero volumio[703]: info: CoreStateMachine::pushState Jun 02 12:32:24 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:24 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 12:32:24 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioPushState Jun 02 12:32:24 volumio-zero-buero volumio[703]: info: CoreStateMachine::updateTrackBlock Jun 02 12:32:24 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrackBlock Jun 02 12:32:24 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 12:32:25 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Total Clients: 12 Jun 02 12:32:25 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Total Clients: 13 Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: MPD running with PID753 Jun 02 12:32:25 volumio-zero-buero volumio[703]: ,establishing connection Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:32:25 volumio-zero-buero volumio[703]: info: Reloading queue from file Jun 02 12:32:26 volumio-zero-buero volumio[703]: error: updateQueue error: null Jun 02 12:32:26 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46:3000 from 192.168.178.37 UA: node-XMLHttpRequest Total Clients: 14 Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CoreStateMachine::pushState Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioPushState Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CoreStateMachine::setRepeat null single undefined Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CoreStateMachine::pushState Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioPushState Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CoreStateMachine::setRandom null Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CoreStateMachine::pushState Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioPushState Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: Setting Device type: Raspberry PI Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: Completed loading Core Plugins Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: Preparing to generate the ALSA configuration file Jun 02 12:32:26 volumio-zero-buero volumio[703]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jun 02 12:32:27 volumio-zero-buero volumio[703]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 02 12:32:27 volumio-zero-buero volumio[703]: info: Reading ALSA contributions from plugins. Jun 02 12:32:27 volumio-zero-buero volumio[703]: error: updateQueue error: null Jun 02 12:32:27 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 02 12:32:27 volumio-zero-buero volumio[703]: info: Discovery: adding 5f6d4c03-cc6e-4f88-afdc-6aacffe7f189 Jun 02 12:32:27 volumio-zero-buero volumio[703]: info: Discovery: Found device Volumio-Zero-Buero Jun 02 12:32:27 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:27 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:27 volumio-zero-buero volumio[703]: Starting albumart workers Jun 02 12:32:27 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:27 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:27 volumio-zero-buero volumio[703]: info: Discovery: adding e7f3d38e-dd83-4285-8c8e-3a26a44d36ea Jun 02 12:32:27 volumio-zero-buero volumio[703]: info: Discovery: Found device Volumio-Zero-Garten Jun 02 12:32:28 volumio-zero-buero sudo[807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Bodo,password=Kanone12,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //Mabo-Fritzbox/Mabo-Fritzbox\Mabo_NAS\My Music /mnt/NAS/Music Jun 02 12:32:28 volumio-zero-buero sudo[807]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:28 volumio-zero-buero sudo[807]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:28 volumio-zero-buero volumio[703]: info: Discovery: Connecting to remote: 192.168.178.37 Jun 02 12:32:28 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 02 12:32:28 volumio-zero-buero volumio[703]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds Jun 02 12:32:28 volumio-zero-buero volumio[703]: info: Discovery: adding 15fc6f14-b264-42d2-828c-6317909a86b1 Jun 02 12:32:28 volumio-zero-buero volumio[703]: info: Discovery: Found device Volumio-Digi-Wohnzimmer Jun 02 12:32:28 volumio-zero-buero volumio[703]: info: Discovery: Connecting to remote: 192.168.178.29 Jun 02 12:32:28 volumio-zero-buero volumio[703]: info: Discovery: Connected to remote: 192.168.178.37 Jun 02 12:32:29 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:29 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:29 volumio-zero-buero volumio[703]: info: Discovery: Connected to remote: 192.168.178.29 Jun 02 12:32:29 volumio-zero-buero volumio[703]: info: Asound.conf file unchanged, so no further update is needed Jun 02 12:32:29 volumio-zero-buero volumio[703]: info: Output device has changed, restarting MPD Jun 02 12:32:30 volumio-zero-buero volumio[703]: info: Output device has changed, restarting Shairport Sync Jun 02 12:32:30 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:30 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:32:30 volumio-zero-buero sudo[812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 12:32:30 volumio-zero-buero sudo[812]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:30 volumio-zero-buero sudo[812]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:30 volumio-zero-buero sudo[814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 12:32:30 volumio-zero-buero sudo[814]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:30 volumio-zero-buero systemd[1]: Stopping Music Player Daemon... Jun 02 12:32:30 volumio-zero-buero systemd[1]: mpd.service: Succeeded. Jun 02 12:32:30 volumio-zero-buero systemd[1]: Stopped Music Player Daemon. Jun 02 12:32:30 volumio-zero-buero volumio[703]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 12:32:30 volumio-zero-buero systemd[1]: Starting Music Player Daemon... Jun 02 12:32:30 volumio-zero-buero volumio[703]: info: ___________ START PLUGINS ___________ Jun 02 12:32:30 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:30 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:32:31 volumio-zero-buero volumio[703]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 12:32:31 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:31 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:32:32 volumio-zero-buero volumio[703]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 12:32:32 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 12:32:32 volumio-zero-buero volumio[703]: info: [1748860352485] CoreMusicLibrary::Adding element Last_100 Jun 02 12:32:32 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:32:32 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 12:32:32 volumio-zero-buero volumio[703]: info: [1748860352639] CoreMusicLibrary::Adding element Webradio Jun 02 12:32:32 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:32:32 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 12:32:33 volumio-zero-buero volumio[703]: info: Creating Spotify config file Jun 02 12:32:33 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:34 volumio-zero-buero volumio-remote-updater[281]: [2025-06-02 12:32:34] [connect] Successful connection Jun 02 12:32:34 volumio-zero-buero volumio[703]: info: Volumio Calling Home Jun 02 12:32:35 volumio-zero-buero volumio[703]: info: Completed starting Core Plugins Jun 02 12:32:35 volumio-zero-buero volumio[703]: info: ------------------------------------------- Jun 02 12:32:35 volumio-zero-buero volumio[703]: info: ----- MyVolumio plugins startup ---- Jun 02 12:32:35 volumio-zero-buero volumio[703]: info: ------------------------------------------- Jun 02 12:32:35 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 02 12:32:35 volumio-zero-buero volumio[703]: error: MPD error: Error: write EPIPE Jun 02 12:32:35 volumio-zero-buero volumio[703]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Jun 02 12:32:36 volumio-zero-buero sudo[841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Bodo,password=Kanone12,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //Mabo-Fritzbox/Mabo-Fritzbox\Mabo_NAS\My Music /mnt/NAS/Music Jun 02 12:32:36 volumio-zero-buero sudo[841]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:36 volumio-zero-buero sudo[845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 02 12:32:36 volumio-zero-buero sudo[845]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:36 volumio-zero-buero sudo[841]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:36 volumio-zero-buero sudo[848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 12:32:36 volumio-zero-buero sudo[848]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:36 volumio-zero-buero sudo[848]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:37 volumio-zero-buero sudo[845]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:37 volumio-zero-buero volumio[703]: info: MPD Permissions set Jun 02 12:32:37 volumio-zero-buero volumio-remote-updater[281]: [2025-06-02 12:32:37] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748860354 101 Jun 02 12:32:37 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 15 Jun 02 12:32:37 volumio-zero-buero volumio[703]: info: Cannot mount NAS Music at system boot, trial number 3 ,retrying in 5 seconds Jun 02 12:32:37 volumio-zero-buero volumio[703]: info: Spotify config file written Jun 02 12:32:37 volumio-zero-buero sudo[854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 02 12:32:37 volumio-zero-buero sudo[854]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:38 volumio-zero-buero systemd[1]: Started go-librespot Daemon. Jun 02 12:32:38 volumio-zero-buero go-librespot[856]: Librespot-go daemon starting... Jun 02 12:32:38 volumio-zero-buero sudo[854]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:38 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 16 Jun 02 12:32:38 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Total Clients: 17 Jun 02 12:32:38 volumio-zero-buero volumio[703]: info: Volumio called home Jun 02 12:32:38 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:38 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:38 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:38 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:38 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:38 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:38 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:38 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:38+02:00" level=info msg="generated new device id: c623c077c81b0bf70bf9cd5a300e0be4f4e7c19d" Jun 02 12:32:38 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:38 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:38+02:00" level=debug msg="stored credentials found for 6v1pmihifkka7u9zc02u07bnu" Jun 02 12:32:39 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:32:39 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:32:40 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Total Clients: 18 Jun 02 12:32:40 volumio-zero-buero volumio[703]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 02 12:32:40 volumio-zero-buero volumio[703]: SPOTIFY: BQBU5m08o8Tc8lTJOxFT3_g33NdJ0wEW-Mqv3FctUX8A9TluhWBRvHY-5GQ105FwnqbVnP2UGt7SFeiu5Ym3Eb0t4omIx9UtUZZx3L6NXU0AI3PzK0pDitxFmXFhdm7OhvnoEM64JcCcnHzhMYnJeuX1zj2uSTa9LCYoeR1XnyN5iRbpQFJQ3dLG0mloLL1mKw_dsuVBQZWEKASvCqY7w3MiOLBl98fej45bJAZCRsOrlqlO4cEYMPGB8xKM3TyBYNn6JtTUnkUynYlpYcsxj1JA2S-ZdzWjz6k2RI1j9RLarWE Jun 02 12:32:40 volumio-zero-buero volumio[703]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 02 12:32:40 volumio-zero-buero volumio[703]: info: New Spotify access token = BQBU5m08o8Tc8lTJOxFT3_g33NdJ0wEW-Mqv3FctUX8A9TluhWBRvHY-5GQ105FwnqbVnP2UGt7SFeiu5Ym3Eb0t4omIx9UtUZZx3L6NXU0AI3PzK0pDitxFmXFhdm7OhvnoEM64JcCcnHzhMYnJeuX1zj2uSTa9LCYoeR1XnyN5iRbpQFJQ3dLG0mloLL1mKw_dsuVBQZWEKASvCqY7w3MiOLBl98fej45bJAZCRsOrlqlO4cEYMPGB8xKM3TyBYNn6JtTUnkUynYlpYcsxj1JA2S-ZdzWjz6k2RI1j9RLarWE Jun 02 12:32:40 volumio-zero-buero volumio[703]: info: Spotify credentials grant success - running version from March 24, 2019 Jun 02 12:32:40 volumio-zero-buero volumio[703]: info: Starting Shairport Sync Jun 02 12:32:41 volumio-zero-buero volumio[703]: info: Starting Shairport Sync Jun 02 12:32:41 volumio-zero-buero volumio[703]: info: Starting Shairport Sync Jun 02 12:32:41 volumio-zero-buero sudo[867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 02 12:32:41 volumio-zero-buero sudo[867]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:41 volumio-zero-buero sudo[869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 02 12:32:42 volumio-zero-buero sudo[869]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:42 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 12:32:42 volumio-zero-buero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 02 12:32:42 volumio-zero-buero systemd[1]: shairport-sync.service: Succeeded. Jun 02 12:32:42 volumio-zero-buero systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 02 12:32:42 volumio-zero-buero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 02 12:32:42 volumio-zero-buero sudo[867]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:42 volumio-zero-buero sudo[871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 02 12:32:42 volumio-zero-buero sudo[871]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:42 volumio-zero-buero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 02 12:32:42 volumio-zero-buero systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 02 12:32:42 volumio-zero-buero systemd[1]: shairport-sync.service: Succeeded. Jun 02 12:32:42 volumio-zero-buero systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 02 12:32:42 volumio-zero-buero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 02 12:32:43 volumio-zero-buero sudo[869]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:43 volumio-zero-buero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 02 12:32:43 volumio-zero-buero systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 02 12:32:43 volumio-zero-buero systemd[1]: shairport-sync.service: Succeeded. Jun 02 12:32:43 volumio-zero-buero systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 02 12:32:43 volumio-zero-buero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 02 12:32:43 volumio-zero-buero sudo[871]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:43 volumio-zero-buero volumio[703]: info: go-librespot daemon successfully initialized Jun 02 12:32:43 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:43+02:00" level=debug msg="obtained new client token: AACJx1QLOxPqOdKVS0goHU/QKA3Rc9uKiiFEqYIriLK0PHjNkKs6rEXIiHeR9vEZRwObnhTjRdG5PNevdTtp7/OTE18P44arQ1qRzG0qTXgw/mipzKXRE9bqXDPaR8tgp7nguhWnED5wD0DjGWCPoqtKV6+qsNepOohjXgcebmjyFPLnWUFp0LSZRO9r9jeZ1VZRebAQ7qroeivqz8hH1gV7hKaB3ZeoiDEkOqsliQV0xg8vcnpg7s+B9FZE/w==" Jun 02 12:32:44 volumio-zero-buero sudo[879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Bodo,password=Kanone12,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //Mabo-Fritzbox/Mabo-Fritzbox\Mabo_NAS\My Music /mnt/NAS/Music Jun 02 12:32:44 volumio-zero-buero sudo[879]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:44 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:44+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Jun 02 12:32:44 volumio-zero-buero sudo[879]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 02 12:32:44 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:44+02:00" level=debug msg="completed keyexchange" Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: Received Get System Info Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: Discovery: Getting this device information Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: Listing playlists Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: Received Get System Info Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: Discovery: Getting this device information Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: Received Get System Info Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: Discovery: Getting this device information Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:44 volumio-zero-buero mpd[828]: Jun 02 12:32 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: Received Get System Info Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: Discovery: Getting this device information Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:44 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:45 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 12:32:45 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:45 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:45 volumio-zero-buero volumio[703]: info: Listing playlists Jun 02 12:32:45 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:45+02:00" level=debug msg="completed challenge" Jun 02 12:32:45 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:45+02:00" level=debug msg="authenticated as 6v1pmihifkka7u9zc02u07bnu" Jun 02 12:32:45 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:45+02:00" level=debug msg="authenticated as 6v1pmihifkka7u9zc02u07bnu" Jun 02 12:32:45 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:45+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jun 02 12:32:45 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:45+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jun 02 12:32:45 volumio-zero-buero volumio[703]: info: Shairport-Sync Started Jun 02 12:32:45 volumio-zero-buero volumio[703]: Error adding Membership: Error: addMembership EINVAL Jun 02 12:32:45 volumio-zero-buero volumio[703]: info: Shairport-Sync Started Jun 02 12:32:45 volumio-zero-buero volumio[703]: info: Shairport-Sync Started Jun 02 12:32:46 volumio-zero-buero volumio[703]: info: Cannot mount NAS Music at system boot, trial number 4 ,retrying in 5 seconds Jun 02 12:32:46 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:46+02:00" level=debug msg="dealer connection opened" Jun 02 12:32:46 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:46+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jun 02 12:32:46 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:46+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jun 02 12:32:46 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:46+02:00" level=debug msg="received connection id: NWI1NWFkNTYtMjM4Mi00ZTc0LTg1ZjUtMTRiMTFmODdmYWFhK2RlYWxlcit0Y3A6Ly8wYWNhNTkwZS5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArMkYyRTJCNUVDMzlFREUwQjc0MDAwMjlFMjI3OTM3NjQ1REJBRDgwRTA2ODhEMzRFOTU5QjM2MDhGNUI1RkE3Nw==" Jun 02 12:32:46 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:46+02:00" level=debug msg="put connect state because NEW_DEVICE" Jun 02 12:32:46 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:46+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 02 12:32:46 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:46+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 02 12:32:46 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:46+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: Initializing connection to go-librespot Websocket Jun 02 12:32:47 volumio-zero-buero mpd[828]: Jun 02 12:32 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:32:47 volumio-zero-buero mpd[828]: Jun 02 12:32 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:32:47 volumio-zero-buero systemd[1]: Started Music Player Daemon. Jun 02 12:32:47 volumio-zero-buero sudo[814]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:47 volumio-zero-buero go-librespot[856]: time="2025-06-02T12:32:47+02:00" level=debug msg="new websocket client" Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: Connection to go-librespot Websocket established Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: Adding plugin bluetooth to MyMusic Plugins Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: Adding plugin multiroom to MyMusic Plugins Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: Adding plugin metavolumio to MyMusic Plugins Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: Adding plugin cd_controller to MyMusic Plugins Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 02 12:32:47 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 02 12:32:53 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 02 12:32:53 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 02 12:32:53 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:32:53 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:32:53 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:32:53 volumio-zero-buero volumio[703]: info: Starting MyVolumio Remote Streaming Endpoints Jun 02 12:32:53 volumio-zero-buero volumio[703]: info: MyVolumio login type: Token Jun 02 12:32:53 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 02 12:32:53 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 02 12:32:58 volumio-zero-buero volumio[703]: info: Starting Streaming Service Transparent Proxy Jun 02 12:32:58 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 02 12:32:58 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 02 12:32:58 volumio-zero-buero volumio[703]: info: Streaming services startup Jun 02 12:32:58 volumio-zero-buero volumio[703]: info: Starting Streaming Daemon Jun 02 12:32:58 volumio-zero-buero sudo[895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 02 12:32:58 volumio-zero-buero sudo[895]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:58 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 02 12:32:58 volumio-zero-buero sudo[895]: pam_unix(sudo:session): session closed for user root Jun 02 12:32:59 volumio-zero-buero sudo[903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Bodo,password=Kanone12,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //Mabo-Fritzbox/Mabo-Fritzbox\Mabo_NAS\My Music /mnt/NAS/Music Jun 02 12:32:59 volumio-zero-buero sudo[903]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:32:59 volumio-zero-buero volumio[703]: info: Getting Spotify volume Jun 02 12:32:59 volumio-zero-buero sudo[903]: pam_unix(sudo:session): session closed for user root Jun 02 12:33:00 volumio-zero-buero volumio[703]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Jun 02 12:33:00 volumio-zero-buero volumio[703]: error: Cannot start Volumio Streaming Daemon Jun 02 12:33:00 volumio-zero-buero volumio[703]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 02 12:33:00 volumio-zero-buero volumio[703]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 02 12:33:00 volumio-zero-buero volumio[703]: info: Spotify volume: 100 Jun 02 12:33:00 volumio-zero-buero volumio[703]: error: updateQueue error: null Jun 02 12:33:00 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 19 Jun 02 12:33:01 volumio-zero-buero volumio[703]: error: MyVolumio Custom Token format not valid, refreshing it Jun 02 12:33:04 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Total Clients: 20 Jun 02 12:33:04 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:33:04 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:33:04 volumio-zero-buero volumio[703]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 02 12:33:04 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:04 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 12:33:04 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:04 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 02 12:33:05 volumio-zero-buero volumio[703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Jun 02 12:33:05 volumio-zero-buero volumio[703]: SPOTIFY: SPOTIFY VOLUME 100 Jun 02 12:33:05 volumio-zero-buero volumio[703]: SPOTIFY: VOLUMIO VOLUME 75 Jun 02 12:33:05 volumio-zero-buero volumio[703]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 12:33:05 volumio-zero-buero volumio[703]: info: Setting Spotify Volume from Volumio: 75 Jun 02 12:33:05 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 12:33:05 volumio-zero-buero volumio-remote-updater[281]: No test mode Jun 02 12:33:05 volumio-zero-buero volumio-remote-updater[281]: No alpha test mode Jun 02 12:33:05 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 02 12:33:05 volumio-zero-buero volumio[703]: SPOTIFY: User informations: {"country":"DE","display_name":"BG","email":"komaoma80@web.de","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/6v1pmihifkka7u9zc02u07bnu"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/6v1pmihifkka7u9zc02u07bnu","id":"6v1pmihifkka7u9zc02u07bnu","images":[{"height":300,"url":"https://i.scdn.co/image/ab6775700000ee859453217df0605a7eb6f22205","width":300},{"height":64,"url":"https://i.scdn.co/image/ab67757000003b829453217df0605a7eb6f22205","width":64}],"product":"premium","type":"user","uri":"spotify:user:6v1pmihifkka7u9zc02u07bnu"} Jun 02 12:33:05 volumio-zero-buero volumio[703]: info: Spotify Successfully logged in Jun 02 12:33:05 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 12:33:05 volumio-zero-buero volumio[703]: info: [1748860385892] CoreMusicLibrary::Adding element Spotify Jun 02 12:33:05 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:33:05 volumio-zero-buero volumio[703]: Cannot find translation for source Spotify Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: Received Get System Info Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: Discovery: Getting this device information Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: Listing playlists Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n\n

NEW ADDITIONS

\n\n","title":"Update v3.812","updateavailable":true} Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 02 12:33:06 volumio-zero-buero volumio[703]: SPOTIFY: SETTING SPOTIFY VOLUME 75 Jun 02 12:33:06 volumio-zero-buero volumio[703]: info: Sending Spotify command with payload to local API: /player/volume Jun 02 12:33:07 volumio-zero-buero volumio[703]: info: MyVolumio login type: Token Jun 02 12:33:07 volumio-zero-buero volumio[703]: error: Failed to send command to Spotify local API: /player/volume: Error: Internal Server Error Jun 02 12:33:08 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 02 12:33:08 volumio-zero-buero volumio[703]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 21 Jun 02 12:33:09 volumio-zero-buero volumio[703]: STREAMING PROXY: Starting server on port 3245 Jun 02 12:33:09 volumio-zero-buero volumio[703]: Node JS runtime: 14 Jun 02 12:33:09 volumio-zero-buero volumio[703]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 02 12:33:09 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetState Jun 02 12:33:09 volumio-zero-buero volumio[703]: info: CorePlayQueue::getTrack 0 Jun 02 12:33:10 volumio-zero-buero volumio[703]: info: MyVolumio token set successfully Jun 02 12:33:10 volumio-zero-buero volumio[703]: info: MYVOLUMIO: Adding device Jun 02 12:33:10 volumio-zero-buero volumio[703]: info: MYVOLUMIO: Evaluating Server Jun 02 12:33:11 volumio-zero-buero volumio[703]: info: MyVolumio Plan changed: premium Jun 02 12:33:11 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jun 02 12:33:11 volumio-zero-buero volumio[703]: info: Removing browser output: myVolumio user plan is not superstar Jun 02 12:33:11 volumio-zero-buero volumio[703]: info: Removing audio output: Jun 02 12:33:11 volumio-zero-buero volumio[703]: info: MYVOLUMIO: Adding device Jun 02 12:33:11 volumio-zero-buero volumio[703]: info: MYVOLUMIO: Evaluating Server Jun 02 12:33:11 volumio-zero-buero volumio[703]: info: Remote config written successfully Jun 02 12:33:11 volumio-zero-buero volumio[703]: info: Starting Tunnel 1 Jun 02 12:33:11 volumio-zero-buero volumio[703]: info: Starting Tunnel Connection Checker Jun 02 12:33:11 volumio-zero-buero volumio[703]: info: Completed starting MyVolumio Plugin Jun 02 12:33:12 volumio-zero-buero volumio[703]: info: MYVolumio Device enabled Jun 02 12:33:12 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jun 02 12:33:12 volumio-zero-buero volumio[703]: info: MyVolumio status changed Jun 02 12:33:12 volumio-zero-buero volumio[703]: info: Streaming services startup Jun 02 12:33:12 volumio-zero-buero volumio[703]: info: Starting Streaming Daemon Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: Setting Geolocation for MyVolumio to eu4 Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:13 volumio-zero-buero sudo[943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 02 12:33:13 volumio-zero-buero sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:33:13 volumio-zero-buero sudo[943]: pam_unix(sudo:session): session closed for user root Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::volumioGetBrowseSources Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: Setting Geolocation for MyVolumio to eu4 Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: error: Cannot start Volumio Streaming Daemon Jun 02 12:33:13 volumio-zero-buero volumio[703]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 02 12:33:13 volumio-zero-buero volumio[703]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jun 02 12:33:13 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:13 volumio-zero-buero volumio[703]: error: [MyVolumio PluginManager] Cache data is invalid! Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: Successfully Added MyVolumio device Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: Successfully Added MyVolumio device Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: Updating MyVolumio device info Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: Updating MyVolumio device info Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: Successfully Updated MyVolumio device Jun 02 12:33:14 volumio-zero-buero volumio[703]: info: Successfully Updated MyVolumio device Jun 02 12:33:15 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Plugin music_service/qobuzconnect is enabled for this plan, but could not be found on the local filesystem! Jun 02 12:33:15 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jun 02 12:33:16 volumio-zero-buero volumio[703]: info: [1748860396378] Starting BluetoothController Jun 02 12:33:16 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jun 02 12:33:24 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Jun 02 12:33:24 volumio-zero-buero sudo[946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /myvolumio/plugins/audio_interface/multiroom/scripts/check_snapcast Jun 02 12:33:24 volumio-zero-buero sudo[946]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:33:24 volumio-zero-buero sudo[946]: pam_unix(sudo:session): session closed for user root Jun 02 12:33:24 volumio-zero-buero sudo[948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jun 02 12:33:24 volumio-zero-buero sudo[948]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:33:24 volumio-zero-buero sudo[948]: pam_unix(sudo:session): session closed for user root Jun 02 12:33:24 volumio-zero-buero sudo[951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get update Jun 02 12:33:24 volumio-zero-buero sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:33:24 volumio-zero-buero volumio[703]: info: MRS: MultiRoom plugin initialized Jun 02 12:33:24 volumio-zero-buero volumio[703]: info: MRS: STOPPING SNAPCLIENT Jun 02 12:33:25 volumio-zero-buero volumio[703]: info: MRS: Snap server stop Jun 02 12:33:25 volumio-zero-buero volumio[703]: info: MRS: STOPPING volumioStreaming Jun 02 12:33:25 volumio-zero-buero sudo[968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jun 02 12:33:25 volumio-zero-buero sudo[968]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:33:25 volumio-zero-buero sudo[971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jun 02 12:33:25 volumio-zero-buero sudo[971]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:33:25 volumio-zero-buero sudo[968]: pam_unix(sudo:session): session closed for user root Jun 02 12:33:25 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jun 02 12:33:25 volumio-zero-buero sudo[974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jun 02 12:33:25 volumio-zero-buero sudo[974]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:33:25 volumio-zero-buero sudo[971]: pam_unix(sudo:session): session closed for user root Jun 02 12:33:26 volumio-zero-buero sudo[977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jun 02 12:33:26 volumio-zero-buero sudo[974]: pam_unix(sudo:session): session closed for user root Jun 02 12:33:26 volumio-zero-buero sudo[977]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 12:33:26 volumio-zero-buero sudo[977]: pam_unix(sudo:session): session closed for user root Jun 02 12:33:26 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jun 02 12:33:26 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jun 02 12:33:26 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jun 02 12:33:26 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jun 02 12:33:27 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Jun 02 12:33:27 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jun 02 12:33:27 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jun 02 12:33:28 volumio-zero-buero volumio[703]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jun 02 12:33:28 volumio-zero-buero volumio[703]: info: Preparing to generate the ALSA configuration file Jun 02 12:33:28 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jun 02 12:33:28 volumio-zero-buero volumio[703]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:33:28 volumio-zero-buero volumio[703]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jun 02 12:33:28 volumio-zero-buero volumio[703]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 02 12:33:28 volumio-zero-buero volumio[703]: info: Reading ALSA contributions from plugins. Jun 02 12:33:28 volumio-zero-buero volumio[703]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 12:33:28 volumio-zero-buero volumio[703]: TypeError: Cannot read property 'id' of null Jun 02 12:33:28 volumio-zero-buero volumio[703]: at multiroom.disableMultiroomSyncOutput (/myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:16769) Jun 02 12:33:28 volumio-zero-buero volumio[703]: at CoreCommandRouter.disableMultiroomSyncOutput (/volumio/app/index.js:1278:23) Jun 02 12:33:28 volumio-zero-buero volumio[703]: at Socket. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:285:28) Jun 02 12:33:28 volumio-zero-buero volumio[703]: at Socket.Emitter.emit (/volumio/node_modules/socket.io-client/node_modules/component-emitter/index.js:133:20) Jun 02 12:33:28 volumio-zero-buero volumio[703]: at Socket.onevent (/volumio/node_modules/socket.io-client/lib/socket.js:270:10) Jun 02 12:33:28 volumio-zero-buero volumio[703]: at Socket.onpacket (/volumio/node_modules/socket.io-client/lib/socket.js:228:12) Jun 02 12:33:28 volumio-zero-buero volumio[703]: at Manager. (/volumio/node_modules/component-bind/index.js:21:15) Jun 02 12:33:28 volumio-zero-buero volumio[703]: at Manager.Emitter.emit (/volumio/node_modules/socket.io-client/node_modules/component-emitter/index.js:133:20) Jun 02 12:33:28 volumio-zero-buero volumio[703]: at Manager.ondecoded (/volumio/node_modules/socket.io-client/lib/manager.js:332:8) Jun 02 12:33:28 volumio-zero-buero volumio[703]: at Decoder. (/volumio/node_modules/component-bind/index.js:21:15) Jun 02 12:33:28 volumio-zero-buero volumio[703]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 12:33:38 volumio-zero-buero sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-02 12:32 Jun 02 12:33:38 volumio-zero-buero sudo[1125]: 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="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"