-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2025-04-21 18:24:32 CEST. -- Apr 21 18:23:00 volumio ntpd[814]: Soliciting pool server 2606:4700:f1::123 Apr 21 18:23:00 volumio ntpd[814]: Soliciting pool server 94.143.139.219 Apr 21 18:23:00 volumio ntpd[814]: Soliciting pool server 5.250.191.170 Apr 21 18:23:00 volumio ntpd[814]: Soliciting pool server 162.159.200.123 Apr 21 18:23:01 volumio ntpd[814]: Soliciting pool server 178.255.228.77 Apr 21 18:23:02 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 21 18:23:03 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:05 volumio ntpd[814]: receive: Unexpected origin timestamp 0xebb0ef68.af9f4461 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xebb0ef69.bc4e3404 Apr 21 18:23:05 volumio ntpd[814]: receive: Unexpected origin timestamp 0xebb0ef68.afa4dd01 does not match aorg 0000000000.00000000 from server@195.95.153.59 xmt 0xebb0ef69.bc8f961c Apr 21 18:23:05 volumio ntpd[814]: receive: Unexpected origin timestamp 0xebb0ef68.af9aa116 does not match aorg 0000000000.00000000 from server@178.255.228.77 xmt 0xebb0ef69.bcd4ff41 Apr 21 18:23:05 volumio ntpd[814]: receive: Unexpected origin timestamp 0xebb0ef68.afa60786 does not match aorg 0000000000.00000000 from server@195.20.235.143 xmt 0xebb0ef69.bd5c37dc Apr 21 18:23:05 volumio ntpd[814]: receive: Unexpected origin timestamp 0xebb0ef68.afa24b7d does not match aorg 0000000000.00000000 from server@90.68.206.60 xmt 0xebb0ef69.bef6ef1e Apr 21 18:23:05 volumio ntpd[814]: receive: Unexpected origin timestamp 0xebb0ef68.afa3aa12 does not match aorg 0000000000.00000000 from server@178.215.228.24 xmt 0xebb0ef69.bdbbd0fc Apr 21 18:23:08 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:11 volumio sudo[2089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 18:23:11 volumio sudo[2089]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 18:23:11 volumio sudo[2089]: pam_unix(sudo:session): session closed for user root Apr 21 18:23:11 volumio sudo[2092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 18:23:11 volumio sudo[2092]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 18:23:11 volumio sudo[2092]: pam_unix(sudo:session): session closed for user root Apr 21 18:23:11 volumio sudo[2095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 21 18:23:11 volumio sudo[2095]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 18:23:11 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 21 18:23:11 volumio sudo[2095]: pam_unix(sudo:session): session closed for user root Apr 21 18:23:11 volumio volumio[869]: info: Upmpdcli Daemon Started Apr 21 18:23:11 volumio volumio[2097]: writing RSA key Apr 21 18:23:11 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 21 18:23:11 volumio volumio[869]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 21 18:23:11 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 21 18:23:11 volumio volumio[869]: info: Received Get System Version Apr 21 18:23:11 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 18:23:11 volumio volumio[869]: info: Received Get System Info Apr 21 18:23:11 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 21 18:23:11 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 21 18:23:11 volumio volumio[869]: info: Discovery: Getting this device information Apr 21 18:23:11 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Apr 21 18:23:11 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:23:11 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 21 18:23:12 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:16 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 21 18:23:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 21 18:23:20 volumio volumio[869]: info: Discovery: Getting this device information Apr 21 18:23:20 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Apr 21 18:23:20 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:23:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 21 18:23:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:23 volumio volumio[869]: info: Clearing queue after UPNP request Apr 21 18:23:24 volumio volumio[869]: info: CoreStateMachine::ClearQueue Apr 21 18:23:24 volumio volumio[869]: info: CoreStateMachine::stop Apr 21 18:23:24 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:23:24 volumio volumio[869]: info: CorePlayQueue::clearPlayQueue Apr 21 18:23:24 volumio volumio[869]: info: CorePlayQueue::saveQueue Apr 21 18:23:24 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:24 volumio volumio[869]: info: CoreCommandRouter::volumioPushQueue Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: error: updateQueue error: null Apr 21 18:23:24 volumio volumio[869]: error: updateQueue error: null Apr 21 18:23:24 volumio volumio[869]: error: updateQueue error: null Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 9ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 6ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 5ms Apr 21 18:23:24 volumio volumio[869]: info: Starting UPNP Playback Apr 21 18:23:24 volumio volumio[869]: info: Preparing playback through UPNP Apr 21 18:23:24 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Apr 21 18:23:24 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:23:24 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 2ms Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 3ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 2ms Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 6ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 3ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 3ms Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 5ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 4ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 4ms Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 3ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 2ms Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 5ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 4ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 3ms Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:23:24 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 5ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 3ms Apr 21 18:23:24 volumio volumio[869]: info: ------------------------------ 3ms Apr 21 18:23:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces state update: player Apr 21 18:23:24 volumio volumio[869]: info: ControllerMpd::getState Apr 21 18:23:24 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces state update: player Apr 21 18:23:24 volumio volumio[869]: info: ControllerMpd::getState Apr 21 18:23:24 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 21 18:23:24 volumio volumio[869]: info: Apr 21 18:23:24 volumio volumio[869]: ---------------------------- MPD announces state update: player Apr 21 18:23:24 volumio volumio[869]: info: ControllerMpd::getState Apr 21 18:23:24 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 21 18:23:25 volumio volumio[869]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 21 18:23:25 volumio volumio[869]: info: sendMpdCommand status took 96 milliseconds Apr 21 18:23:25 volumio volumio[869]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 21 18:23:25 volumio volumio[869]: info: sendMpdCommand status took 95 milliseconds Apr 21 18:23:25 volumio volumio[869]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 21 18:23:25 volumio volumio[869]: info: sendMpdCommand status took 94 milliseconds Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::parseState Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::parseState Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::parseState Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 18:23:25 volumio volumio[869]: info: sendMpdCommand clearerror took 26 milliseconds Apr 21 18:23:25 volumio volumio[869]: info: sendMpdCommand clearerror took 28 milliseconds Apr 21 18:23:25 volumio volumio[869]: info: sendMpdCommand clearerror took 27 milliseconds Apr 21 18:23:25 volumio volumio[869]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 21 18:23:25 volumio volumio[869]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 21 18:23:25 volumio volumio[869]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 21 18:23:25 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 21 18:23:25 volumio volumio[869]: info: ControllerMpd::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::servicePushState Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:25 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:23:25 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Cuarto de Tula","artist":"Buena Vista Social Club","album":"Buena Vista Social Club","uri":"http://127.0.0.1:57645/proxy/qobuz/CEECC375FF58C934544EF68F682A862A.flac?proxy=false","trackType":"qobuz"} Apr 21 18:23:25 volumio volumio[869]: verbose: CURRENT POSITION 0 Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:25 volumio volumio[869]: info: No code Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:25 volumio volumio[869]: info: ControllerMpd::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::servicePushState Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:25 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:23:25 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Cuarto de Tula","artist":"Buena Vista Social Club","album":"Buena Vista Social Club","uri":"http://127.0.0.1:57645/proxy/qobuz/CEECC375FF58C934544EF68F682A862A.flac?proxy=false","trackType":"qobuz"} Apr 21 18:23:25 volumio volumio[869]: verbose: CURRENT POSITION 0 Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:25 volumio volumio[869]: info: No code Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:25 volumio volumio[869]: info: ControllerMpd::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::servicePushState Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:25 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:23:25 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Cuarto de Tula","artist":"Buena Vista Social Club","album":"Buena Vista Social Club","uri":"http://127.0.0.1:57645/proxy/qobuz/CEECC375FF58C934544EF68F682A862A.flac?proxy=false","trackType":"qobuz"} Apr 21 18:23:25 volumio volumio[869]: verbose: CURRENT POSITION 0 Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:25 volumio volumio[869]: info: No code Apr 21 18:23:25 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:25 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:25 volumio volumio[869]: info: ------------------------------ 249ms Apr 21 18:23:25 volumio volumio[869]: info: ------------------------------ 247ms Apr 21 18:23:25 volumio volumio[869]: info: ------------------------------ 246ms Apr 21 18:23:26 volumio volumio[869]: info: Moving to next track after playback error Apr 21 18:23:26 volumio volumio[869]: info: CoreCommandRouter::volumioPlay Apr 21 18:23:26 volumio volumio[869]: info: CoreStateMachine::play index 1 Apr 21 18:23:26 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:23:26 volumio volumio[869]: info: CoreStateMachine::stop Apr 21 18:23:26 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:23:26 volumio volumio[869]: info: CoreStateMachine::play index undefined Apr 21 18:23:26 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:23:26 volumio volumio[869]: info: CorePlayQueue::getTrack 1 Apr 21 18:23:28 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:32 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:36 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:39 volumio volumio[869]: info: Disabling MyMusic plugin upnp Apr 21 18:23:39 volumio sudo[2178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 21 18:23:39 volumio sudo[2178]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 18:23:39 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Apr 21 18:23:39 volumio systemd[1]: upmpdcli.service: Succeeded. Apr 21 18:23:39 volumio systemd[1]: Stopped UPnP Renderer front-end to MPD. Apr 21 18:23:39 volumio sudo[2178]: pam_unix(sudo:session): session closed for user root Apr 21 18:23:39 volumio volumio[869]: info: Disabling plugin upnp Apr 21 18:23:39 volumio volumio[869]: info: Done. Apr 21 18:23:40 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:42 volumio volumio[869]: info: Enabling MyMusic plugin upnp Apr 21 18:23:42 volumio volumio[869]: info: Enabling plugin upnp Apr 21 18:23:42 volumio volumio[869]: info: Loading plugin "upnp"... Apr 21 18:23:42 volumio volumio[869]: info: [1745252622441] Starting Upmpd Daemon Apr 21 18:23:42 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 18:23:42 volumio volumio[869]: info: Done. Apr 21 18:23:44 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:48 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:50 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 21 18:23:50 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 21 18:23:50 volumio volumio[869]: info: Discovery: Getting this device information Apr 21 18:23:50 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Apr 21 18:23:50 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:23:50 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 21 18:23:52 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:52 volumio sudo[2259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 18:23:52 volumio sudo[2259]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 18:23:52 volumio sudo[2259]: pam_unix(sudo:session): session closed for user root Apr 21 18:23:52 volumio sudo[2262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 18:23:52 volumio sudo[2262]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 18:23:52 volumio sudo[2262]: pam_unix(sudo:session): session closed for user root Apr 21 18:23:52 volumio sudo[2265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 21 18:23:52 volumio sudo[2265]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 18:23:52 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 21 18:23:52 volumio sudo[2265]: pam_unix(sudo:session): session closed for user root Apr 21 18:23:52 volumio volumio[869]: info: Upmpdcli Daemon Started Apr 21 18:23:52 volumio volumio[2267]: writing RSA key Apr 21 18:23:52 volumio kernel: usb 1-1.4: USB disconnect, device number 3 Apr 21 18:23:53 volumio volumio[869]: info: Apr 21 18:23:53 volumio volumio[869]: ---------------------------- USB Audio Device Detached Apr 21 18:23:53 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 21 18:23:53 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 18:23:53 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 21 18:23:53 volumio volumio[869]: info: No valid Plugin REST Endpoint Apr 21 18:23:54 volumio kernel: usb 1-1.4: new high-speed USB device number 4 using xhci_hcd Apr 21 18:23:54 volumio kernel: usb 1-1.4: New USB device found, idVendor=2a39, idProduct=3fd3, bcdDevice= 0.01 Apr 21 18:23:54 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 21 18:23:54 volumio kernel: usb 1-1.4: Product: ADI-2 DAC (51110073) Apr 21 18:23:54 volumio kernel: usb 1-1.4: Manufacturer: RME Apr 21 18:23:54 volumio kernel: usb 1-1.4: SerialNumber: B9EEF0E1F738BC8 Apr 21 18:23:54 volumio volumio[869]: info: Apr 21 18:23:54 volumio volumio[869]: ---------------------------- USB Audio Device Attached Apr 21 18:23:54 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 21 18:23:54 volumio volumio[869]: info: CoreCommandRouter::Close All Modals sent Apr 21 18:23:54 volumio volumio[869]: info: Preparing to save Alsa Options, stopping services first Apr 21 18:23:54 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Apr 21 18:23:54 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:23:54 volumio volumio[869]: info: CoreCommandRouter::volumioPause Apr 21 18:23:54 volumio volumio[869]: info: CoreStateMachine::pause Apr 21 18:23:54 volumio volumio[869]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"ADI-2 DAC (51110073)","alsacard":"DAC51110073"},"i2s":false} Apr 21 18:23:54 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 18:23:54 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 18:23:54 volumio volumio[869]: info: Setting mixer AES Rate for card ADI-2 DAC (51110073) Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 21 18:23:55 volumio volumio[869]: info: Updating Volume Controller Parameters: Device: 5 Name: ADI-2 DAC (51110073) Mixer: AES Rate Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 21 18:23:55 volumio volumio[869]: info: Disabling external Volume Control Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 18:23:55 volumio volumio[869]: info: Preparing to generate the ALSA configuration file Apr 21 18:23:55 volumio volumio[869]: Unable to parse: Apr 21 18:23:55 volumio volumio[869]: Simple mixer control 'AES Rate',0 Apr 21 18:23:55 volumio volumio[869]: Capabilities: volume volume-joined Apr 21 18:23:55 volumio volumio[869]: Playback channels: Mono Apr 21 18:23:55 volumio volumio[869]: Capture channels: Mono Apr 21 18:23:55 volumio volumio[869]: Limits: 0 - 200000 Apr 21 18:23:55 volumio volumio[869]: Mono: 0 [0%] Apr 21 18:23:55 volumio volumio[869]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Apr 21 18:23:55 volumio volumio[869]: info: No valid Plugin REST Endpoint Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 21 18:23:55 volumio volumio[869]: info: Asound.conf file unchanged, so no further update is needed Apr 21 18:23:55 volumio volumio[869]: info: Output device has changed, restarting MPD Apr 21 18:23:55 volumio sudo[2330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 21 18:23:55 volumio sudo[2330]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 18:23:55 volumio sudo[2330]: pam_unix(sudo:session): session closed for user root Apr 21 18:23:55 volumio volumio[869]: Unable to parse: Apr 21 18:23:55 volumio volumio[869]: Simple mixer control 'AES Rate',0 Apr 21 18:23:55 volumio volumio[869]: Capabilities: volume volume-joined Apr 21 18:23:55 volumio volumio[869]: Playback channels: Mono Apr 21 18:23:55 volumio volumio[869]: Capture channels: Mono Apr 21 18:23:55 volumio volumio[869]: Limits: 0 - 200000 Apr 21 18:23:55 volumio volumio[869]: Mono: 0 [0%] Apr 21 18:23:55 volumio volumio[869]: info: VolumeController:: Volume=undefined Mute =false Apr 21 18:23:55 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:55 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:55 volumio sudo[2333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 21 18:23:55 volumio sudo[2333]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 18:23:55 volumio volumio[869]: info: MPD Permissions set Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 18:23:55 volumio systemd[1]: musicservicesshield.service: Succeeded. Apr 21 18:23:55 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Apr 21 18:23:55 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Apr 21 18:23:55 volumio systemd[1]: Stopping Music Player Daemon... Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 18:23:55 volumio systemd[1]: mpd.service: Succeeded. Apr 21 18:23:55 volumio systemd[1]: Stopped Music Player Daemon. Apr 21 18:23:55 volumio systemd[1]: Starting Music Player Daemon... Apr 21 18:23:55 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 21 18:23:55 volumio sudo[2339]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 21 18:23:55 volumio sudo[2339]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 18:23:55 volumio sudo[2339]: pam_unix(sudo:session): session closed for user root Apr 21 18:23:56 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:23:56 volumio volumio[869]: error: MPD error: Error: This socket has been ended by the other party Apr 21 18:23:56 volumio volumio[869]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 21 18:23:56 volumio volumio[869]: error: MPD error: Error: This socket has been ended by the other party Apr 21 18:23:56 volumio volumio[869]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 21 18:23:56 volumio volumio[869]: error: MPD error: Error: This socket has been ended by the other party Apr 21 18:23:56 volumio volumio[869]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 21 18:23:56 volumio mpd[2341]: Apr 21 18:23 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 21 18:23:56 volumio systemd[1]: Started Music Player Daemon. Apr 21 18:23:56 volumio sudo[2333]: pam_unix(sudo:session): session closed for user root Apr 21 18:23:56 volumio volumio[869]: error: updateQueue error: null Apr 21 18:23:56 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 21 18:23:57 volumio volumio[2344]: cset: --> shielding system active with Apr 21 18:23:57 volumio volumio[2344]: cset: "system" cpuset of CPUSPEC(0,3) with 235 tasks running Apr 21 18:23:57 volumio volumio[2344]: cset: "user" cpuset of CPUSPEC(1-2) with 3 tasks running Apr 21 18:23:57 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 21 18:23:59 volumio volumio[869]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 21 18:23:59 volumio volumio[869]: info: CoreStateMachine::getcurrentVolume Apr 21 18:23:59 volumio volumio[869]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 18:23:59 volumio volumio[869]: Unable to parse: Apr 21 18:23:59 volumio volumio[869]: Simple mixer control 'AES Rate',0 Apr 21 18:23:59 volumio volumio[869]: Capabilities: volume volume-joined Apr 21 18:23:59 volumio volumio[869]: Playback channels: Mono Apr 21 18:23:59 volumio volumio[869]: Capture channels: Mono Apr 21 18:23:59 volumio volumio[869]: Limits: 0 - 200000 Apr 21 18:23:59 volumio volumio[869]: Mono: 0 [0%] Apr 21 18:23:59 volumio volumio[869]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Apr 21 18:23:59 volumio volumio[869]: Unable to parse: Apr 21 18:23:59 volumio volumio[869]: Simple mixer control 'AES Rate',0 Apr 21 18:23:59 volumio volumio[869]: Capabilities: volume volume-joined Apr 21 18:23:59 volumio volumio[869]: Playback channels: Mono Apr 21 18:23:59 volumio volumio[869]: Capture channels: Mono Apr 21 18:23:59 volumio volumio[869]: Limits: 0 - 200000 Apr 21 18:23:59 volumio volumio[869]: Mono: 0 [0%] Apr 21 18:23:59 volumio volumio[869]: info: VolumeController:: Volume=undefined Mute =false Apr 21 18:23:59 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:59 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:23:59 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:23:59 volumio volumio[869]: info: CoreStateMachine::updateTrackBlock Apr 21 18:23:59 volumio volumio[869]: info: CorePlayQueue::getTrackBlock Apr 21 18:23:59 volumio volumio[869]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 18:23:59 volumio volumio[869]: Unable to parse: Apr 21 18:23:59 volumio volumio[869]: Simple mixer control 'AES Rate',0 Apr 21 18:23:59 volumio volumio[869]: Capabilities: volume volume-joined Apr 21 18:23:59 volumio volumio[869]: Playback channels: Mono Apr 21 18:23:59 volumio volumio[869]: Capture channels: Mono Apr 21 18:23:59 volumio volumio[869]: Limits: 0 - 200000 Apr 21 18:23:59 volumio volumio[869]: Mono: 0 [0%] Apr 21 18:23:59 volumio volumio[869]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Apr 21 18:23:59 volumio volumio[869]: Unable to parse: Apr 21 18:23:59 volumio volumio[869]: Simple mixer control 'AES Rate',0 Apr 21 18:23:59 volumio volumio[869]: Capabilities: volume volume-joined Apr 21 18:23:59 volumio volumio[869]: Playback channels: Mono Apr 21 18:23:59 volumio volumio[869]: Capture channels: Mono Apr 21 18:23:59 volumio volumio[869]: Limits: 0 - 200000 Apr 21 18:23:59 volumio volumio[869]: Mono: 0 [0%] Apr 21 18:23:59 volumio volumio[869]: info: VolumeController:: Volume=undefined Mute =false Apr 21 18:23:59 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:23:59 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:23:59 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:00 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:24:04 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:24:05 volumio volumio[869]: info: Clearing queue after UPNP request Apr 21 18:24:05 volumio volumio[869]: info: CoreStateMachine::ClearQueue Apr 21 18:24:05 volumio volumio[869]: info: CoreStateMachine::stop Apr 21 18:24:05 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:05 volumio volumio[869]: info: CorePlayQueue::clearPlayQueue Apr 21 18:24:05 volumio volumio[869]: info: CorePlayQueue::saveQueue Apr 21 18:24:05 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:05 volumio volumio[869]: info: CoreCommandRouter::volumioPushQueue Apr 21 18:24:05 volumio volumio[869]: error: Upnp client error: Error: This socket has been ended by the other party Apr 21 18:24:07 volumio volumio[869]: info: Starting UPNP Playback Apr 21 18:24:07 volumio volumio[869]: info: Preparing playback through UPNP Apr 21 18:24:07 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Apr 21 18:24:07 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:24:07 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 21 18:24:08 volumio volumio[869]: info: Apr 21 18:24:08 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:08 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:08 volumio volumio[869]: info: Apr 21 18:24:08 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:08 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:08 volumio volumio[869]: info: ------------------------------ 2ms Apr 21 18:24:08 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:08 volumio volumio[869]: info: Apr 21 18:24:08 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:08 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:08 volumio volumio[869]: info: ------------------------------ 2ms Apr 21 18:24:08 volumio volumio[869]: info: Apr 21 18:24:08 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:08 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:08 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:08 volumio volumio[869]: info: Apr 21 18:24:08 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:08 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:08 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:08 volumio volumio[869]: info: Apr 21 18:24:08 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:08 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:08 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:08 volumio volumio[869]: info: Apr 21 18:24:08 volumio volumio[869]: ---------------------------- MPD announces state update: player Apr 21 18:24:08 volumio volumio[869]: info: ControllerMpd::getState Apr 21 18:24:08 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 21 18:24:08 volumio volumio[869]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 21 18:24:08 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 21 18:24:08 volumio volumio[869]: info: sendMpdCommand status took 6 milliseconds Apr 21 18:24:08 volumio volumio[869]: verbose: ControllerMpd::parseState Apr 21 18:24:08 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 18:24:08 volumio volumio[869]: info: sendMpdCommand clearerror took 3 milliseconds Apr 21 18:24:08 volumio volumio[869]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 21 18:24:08 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 21 18:24:08 volumio volumio[869]: info: ControllerMpd::pushState Apr 21 18:24:08 volumio volumio[869]: info: CoreCommandRouter::servicePushState Apr 21 18:24:08 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:08 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 18:24:08 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:08 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:24:08 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Cuarto de Tula","artist":"Buena Vista Social Club","album":"Buena Vista Social Club","uri":"http://127.0.0.1:57645/proxy/qobuz/CEECC375FF58C934544EF68F682A862A.flac?proxy=false","trackType":"qobuz"} Apr 21 18:24:08 volumio volumio[869]: verbose: CURRENT POSITION 0 Apr 21 18:24:08 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop Apr 21 18:24:08 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop Apr 21 18:24:08 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:08 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:08 volumio volumio[869]: info: No code Apr 21 18:24:08 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:08 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:08 volumio volumio[869]: info: ------------------------------ 60ms Apr 21 18:24:08 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:24:09 volumio volumio[869]: info: Moving to next track after playback error Apr 21 18:24:09 volumio volumio[869]: info: CoreCommandRouter::volumioPlay Apr 21 18:24:09 volumio volumio[869]: info: CoreStateMachine::play index 1 Apr 21 18:24:09 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:09 volumio volumio[869]: info: CoreStateMachine::stop Apr 21 18:24:09 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:09 volumio volumio[869]: info: CoreStateMachine::play index undefined Apr 21 18:24:09 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:09 volumio volumio[869]: info: CorePlayQueue::getTrack 1 Apr 21 18:24:12 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:24:14 volumio volumio[869]: info: Clearing queue after UPNP request Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::ClearQueue Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::stop Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:15 volumio volumio[869]: info: CorePlayQueue::clearPlayQueue Apr 21 18:24:15 volumio volumio[869]: info: CorePlayQueue::saveQueue Apr 21 18:24:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushQueue Apr 21 18:24:15 volumio volumio[869]: info: Apr 21 18:24:15 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:15 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:15 volumio volumio[869]: error: updateQueue error: null Apr 21 18:24:15 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:15 volumio volumio[869]: info: Starting UPNP Playback Apr 21 18:24:15 volumio volumio[869]: info: Preparing playback through UPNP Apr 21 18:24:15 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Apr 21 18:24:15 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 21 18:24:15 volumio volumio[869]: info: Apr 21 18:24:15 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:15 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:15 volumio volumio[869]: info: Apr 21 18:24:15 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:15 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:15 volumio volumio[869]: info: ------------------------------ 2ms Apr 21 18:24:15 volumio volumio[869]: info: ------------------------------ 2ms Apr 21 18:24:15 volumio volumio[869]: info: Apr 21 18:24:15 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:15 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:15 volumio volumio[869]: info: ------------------------------ 2ms Apr 21 18:24:15 volumio volumio[869]: info: Apr 21 18:24:15 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:15 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:15 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:15 volumio volumio[869]: info: Apr 21 18:24:15 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:15 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:15 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:15 volumio volumio[869]: info: Apr 21 18:24:15 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:15 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:15 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:15 volumio volumio[869]: info: Apr 21 18:24:15 volumio volumio[869]: ---------------------------- MPD announces state update: player Apr 21 18:24:15 volumio volumio[869]: info: ControllerMpd::getState Apr 21 18:24:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 21 18:24:15 volumio volumio[869]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 21 18:24:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 21 18:24:15 volumio volumio[869]: info: sendMpdCommand status took 7 milliseconds Apr 21 18:24:15 volumio volumio[869]: verbose: ControllerMpd::parseState Apr 21 18:24:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 18:24:15 volumio volumio[869]: info: sendMpdCommand clearerror took 2 milliseconds Apr 21 18:24:15 volumio volumio[869]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 21 18:24:15 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 21 18:24:15 volumio volumio[869]: info: ControllerMpd::pushState Apr 21 18:24:15 volumio volumio[869]: info: CoreCommandRouter::servicePushState Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:15 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:24:15 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Día Que Me Quieras","artist":"Paolo Fresu","album":"El Día Que Me Quieras","uri":"http://127.0.0.1:57645/proxy/qobuz/1527FC73BBA3B7C13CF320F367AD55BF.flac?proxy=false","trackType":"qobuz"} Apr 21 18:24:15 volumio volumio[869]: verbose: CURRENT POSITION 0 Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:15 volumio volumio[869]: info: No code Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:15 volumio volumio[869]: info: ------------------------------ 47ms Apr 21 18:24:15 volumio volumio[869]: info: Apr 21 18:24:15 volumio volumio[869]: ---------------------------- MPD announces state update: player Apr 21 18:24:15 volumio volumio[869]: info: ControllerMpd::getState Apr 21 18:24:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 21 18:24:15 volumio volumio[869]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 21 18:24:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 21 18:24:15 volumio volumio[869]: info: sendMpdCommand status took 5 milliseconds Apr 21 18:24:15 volumio volumio[869]: verbose: ControllerMpd::parseState Apr 21 18:24:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 18:24:15 volumio volumio[869]: info: sendMpdCommand clearerror took 2 milliseconds Apr 21 18:24:15 volumio volumio[869]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 21 18:24:15 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 21 18:24:15 volumio volumio[869]: info: ControllerMpd::pushState Apr 21 18:24:15 volumio volumio[869]: info: CoreCommandRouter::servicePushState Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:15 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:24:15 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Día Que Me Quieras","artist":"Paolo Fresu","album":"El Día Que Me Quieras","uri":"http://127.0.0.1:57645/proxy/qobuz/1527FC73BBA3B7C13CF320F367AD55BF.flac?proxy=false","trackType":"qobuz"} Apr 21 18:24:15 volumio volumio[869]: verbose: CURRENT POSITION 0 Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:15 volumio volumio[869]: info: No code Apr 21 18:24:15 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:15 volumio volumio[869]: info: ------------------------------ 46ms Apr 21 18:24:16 volumio volumio[869]: info: Moving to next track after playback error Apr 21 18:24:16 volumio volumio[869]: info: CoreCommandRouter::volumioPlay Apr 21 18:24:16 volumio volumio[869]: info: CoreStateMachine::play index 1 Apr 21 18:24:16 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:16 volumio volumio[869]: info: CoreStateMachine::stop Apr 21 18:24:16 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:16 volumio volumio[869]: info: CoreStateMachine::play index undefined Apr 21 18:24:16 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:16 volumio volumio[869]: info: CorePlayQueue::getTrack 1 Apr 21 18:24:16 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:24:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 21 18:24:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 21 18:24:20 volumio volumio[869]: info: Discovery: Getting this device information Apr 21 18:24:20 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Apr 21 18:24:20 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:24:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 21 18:24:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:24:21 volumio volumio[869]: info: Clearing queue after UPNP request Apr 21 18:24:21 volumio volumio[869]: info: CoreStateMachine::ClearQueue Apr 21 18:24:21 volumio volumio[869]: info: CoreStateMachine::stop Apr 21 18:24:21 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:21 volumio volumio[869]: info: CorePlayQueue::clearPlayQueue Apr 21 18:24:21 volumio volumio[869]: info: CorePlayQueue::saveQueue Apr 21 18:24:21 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:21 volumio volumio[869]: info: CoreCommandRouter::volumioPushQueue Apr 21 18:24:21 volumio volumio[869]: info: Apr 21 18:24:21 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:21 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:21 volumio volumio[869]: error: updateQueue error: null Apr 21 18:24:21 volumio volumio[869]: info: ------------------------------ 2ms Apr 21 18:24:21 volumio volumio[869]: info: Starting UPNP Playback Apr 21 18:24:21 volumio volumio[869]: info: Preparing playback through UPNP Apr 21 18:24:21 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Apr 21 18:24:21 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:24:21 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 21 18:24:21 volumio volumio[869]: info: Apr 21 18:24:21 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:21 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:21 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:21 volumio volumio[869]: info: Apr 21 18:24:21 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:21 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:21 volumio volumio[869]: info: Apr 21 18:24:21 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:21 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:21 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:21 volumio volumio[869]: info: Apr 21 18:24:21 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:21 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:21 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:21 volumio volumio[869]: info: Apr 21 18:24:21 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:21 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:21 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:21 volumio volumio[869]: info: Apr 21 18:24:21 volumio volumio[869]: ---------------------------- MPD announces system playlist update Apr 21 18:24:21 volumio volumio[869]: info: Ignoring MPD Status Update Apr 21 18:24:21 volumio volumio[869]: info: ------------------------------ 1ms Apr 21 18:24:22 volumio volumio[869]: info: Apr 21 18:24:22 volumio volumio[869]: ---------------------------- MPD announces state update: player Apr 21 18:24:22 volumio volumio[869]: info: ControllerMpd::getState Apr 21 18:24:22 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 21 18:24:22 volumio volumio[869]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 21 18:24:22 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 21 18:24:22 volumio volumio[869]: info: sendMpdCommand status took 7 milliseconds Apr 21 18:24:22 volumio volumio[869]: verbose: ControllerMpd::parseState Apr 21 18:24:22 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 18:24:22 volumio volumio[869]: info: sendMpdCommand clearerror took 3 milliseconds Apr 21 18:24:22 volumio volumio[869]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 21 18:24:22 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 21 18:24:22 volumio volumio[869]: info: ControllerMpd::pushState Apr 21 18:24:22 volumio volumio[869]: info: CoreCommandRouter::servicePushState Apr 21 18:24:22 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:22 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:22 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Apr 21 18:24:22 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Día Que Me Quieras","artist":"Paolo Fresu","album":"El Día Que Me Quieras","uri":"http://127.0.0.1:57645/proxy/qobuz/1527FC73BBA3B7C13CF320F367AD55BF.flac?proxy=false","trackType":"qobuz"} Apr 21 18:24:22 volumio volumio[869]: verbose: CURRENT POSITION 0 Apr 21 18:24:22 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop Apr 21 18:24:22 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop Apr 21 18:24:22 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:22 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:22 volumio volumio[869]: info: No code Apr 21 18:24:22 volumio volumio[869]: info: CoreStateMachine::pushState Apr 21 18:24:22 volumio volumio[869]: info: CoreCommandRouter::volumioPushState Apr 21 18:24:22 volumio volumio[869]: info: ------------------------------ 66ms Apr 21 18:24:23 volumio volumio[869]: info: Moving to next track after playback error Apr 21 18:24:23 volumio volumio[869]: info: CoreCommandRouter::volumioPlay Apr 21 18:24:23 volumio volumio[869]: info: CoreStateMachine::play index 1 Apr 21 18:24:23 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:23 volumio volumio[869]: info: CoreStateMachine::stop Apr 21 18:24:23 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:23 volumio volumio[869]: info: CoreStateMachine::play index undefined Apr 21 18:24:23 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 18:24:23 volumio volumio[869]: info: CorePlayQueue::getTrack 1 Apr 21 18:24:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:24:28 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:24:28 volumio volumio[869]: info: Disabling MyMusic plugin upnp Apr 21 18:24:28 volumio sudo[2444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 21 18:24:28 volumio sudo[2444]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 18:24:28 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Apr 21 18:24:28 volumio volumio[869]: error: Upnp client error: Error: This socket has been ended by the other party Apr 21 18:24:32 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 18:24:32 volumio volumio[869]: info: Enabling MyMusic plugin upnp Apr 21 18:24:32 volumio volumio[869]: info: Enabling plugin upnp Apr 21 18:24:32 volumio volumio[869]: info: Loading plugin "upnp"... Apr 21 18:24:32 volumio volumio[869]: info: [1745252672507] Starting Upmpd Daemon Apr 21 18:24:32 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 18:24:32 volumio volumio[869]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 18:24:32 volumio volumio[869]: Error: listen EADDRINUSE: address already in use :::6599 Apr 21 18:24:32 volumio volumio[869]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Apr 21 18:24:32 volumio volumio[869]: at listenInCluster (net.js:1366:12) Apr 21 18:24:32 volumio volumio[869]: at Server.listen (net.js:1452:7) Apr 21 18:24:32 volumio volumio[869]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Apr 21 18:24:32 volumio volumio[869]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Apr 21 18:24:32 volumio volumio[869]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 21 18:24:32 volumio volumio[869]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 21 18:24:32 volumio volumio[869]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Apr 21 18:24:32 volumio volumio[869]: code: 'EADDRINUSE', Apr 21 18:24:32 volumio volumio[869]: errno: -98, Apr 21 18:24:32 volumio volumio[869]: syscall: 'listen', Apr 21 18:24:32 volumio volumio[869]: address: '::', Apr 21 18:24:32 volumio volumio[869]: port: 6599 Apr 21 18:24:32 volumio volumio[869]: } Apr 21 18:24:32 volumio volumio[869]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 18:24:32 volumio sudo[2469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-21 18:23 Apr 21 18:24:32 volumio sudo[2469]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"