-- Logs begin at Fri 2025-04-04 05:35:12 CEST, end at Mon 2025-04-14 11:29:54 CEST. -- Apr 14 11:28:00 rivo volumio[3116]: info: Volumio Network Manager: Network status updated: 1 Apr 14 11:28:00 rivo volumio[3116]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 14 11:28:00 rivo volumio[3116]: info: Updating MyVolumio device info Apr 14 11:28:00 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 11:28:00 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 11:28:01 rivo volumio[3116]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 14 11:28:01 rivo volumio[3116]: info: CoreCommandRouter::volumioPlay Apr 14 11:28:01 rivo volumio[3116]: info: CoreStateMachine::play index undefined Apr 14 11:28:01 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:01 rivo volumio[3116]: info: CorePlayQueue::getTrack 0 Apr 14 11:28:01 rivo volumio[3116]: info: CoreStateMachine::startPlaybackTimer Apr 14 11:28:01 rivo volumio[3116]: info: CorePlayQueue::getTrack 0 Apr 14 11:28:01 rivo volumio[3116]: info: [1744622881960] ControllerQobuz::clearAddPlayTrack Apr 14 11:28:01 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand stop Apr 14 11:28:01 rivo volumio[3116]: info: sendMpdCommand stop took 3 milliseconds Apr 14 11:28:01 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clear Apr 14 11:28:01 rivo volumio[3116]: info: Apr 14 11:28:01 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:01 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:01 rivo volumio[3116]: info: sendMpdCommand clear took 4 milliseconds Apr 14 11:28:01 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/22940094" Apr 14 11:28:01 rivo volumio[3116]: error: updateQueue error: null Apr 14 11:28:01 rivo volumio[3116]: info: ------------------------------ 6ms Apr 14 11:28:01 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940094 Apr 14 11:28:02 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:02 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:02 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 14 11:28:02 rivo volumio[3116]: info: getStreamUrl took 172 milliseconds Apr 14 11:28:02 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:02 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:02 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940094" Apr 14 11:28:02 rivo volumio[3116]: info: Apr 14 11:28:02 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:02 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:02 rivo volumio[3116]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940094" took 2 milliseconds Apr 14 11:28:02 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 14 11:28:02 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand play Apr 14 11:28:02 rivo volumio[3116]: info: ------------------------------ 7ms Apr 14 11:28:02 rivo volumio[3116]: info: sendMpdCommand play took 5 milliseconds Apr 14 11:28:02 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940094 Apr 14 11:28:02 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:02 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:02 rivo volumio[3116]: info: getStreamUrl took 103 milliseconds Apr 14 11:28:02 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:02 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:02 rivo volumio[3116]: info: Apr 14 11:28:02 rivo volumio[3116]: ---------------------------- MPD announces state update: player Apr 14 11:28:02 rivo volumio[3116]: info: ControllerMpd::getState Apr 14 11:28:02 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand status Apr 14 11:28:02 rivo volumio[3116]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 14 11:28:02 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 14 11:28:02 rivo volumio[3116]: info: sendMpdCommand status took 9 milliseconds Apr 14 11:28:02 rivo volumio[3116]: verbose: ControllerMpd::parseState Apr 14 11:28:02 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 11:28:02 rivo volumio[3116]: info: sendMpdCommand clearerror took 6 milliseconds Apr 14 11:28:02 rivo volumio[3116]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 14 11:28:02 rivo volumio[3116]: verbose: ControllerMpd::parseTrackInfo Apr 14 11:28:02 rivo volumio[3116]: info: ControllerMpd::pushState Apr 14 11:28:02 rivo volumio[3116]: info: CoreCommandRouter::servicePushState Apr 14 11:28:02 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:02 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 11:28:02 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:02 rivo volumio[3116]: info: CorePlayQueue::getTrack 0 Apr 14 11:28:02 rivo volumio[3116]: 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":"22940094","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/22940094","trackType":"qobuz"} Apr 14 11:28:02 rivo volumio[3116]: verbose: CURRENT POSITION 0 Apr 14 11:28:02 rivo volumio[3116]: info: CoreStateMachine::syncState stateService stop Apr 14 11:28:02 rivo volumio[3116]: info: CoreStateMachine::syncState currentStatus stop Apr 14 11:28:02 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:02 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:02 rivo volumio[3116]: info: No code Apr 14 11:28:02 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:02 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:02 rivo volumio[3116]: info: ------------------------------ 44ms Apr 14 11:28:02 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:02 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:02 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:02 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:02 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:03 rivo nmbd[3067]: [2025/04/14 11:28:03.373970, 0] ../source3/libsmb/nmblib.c:917(send_udp) Apr 14 11:28:03 rivo nmbd[3067]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Apr 14 11:28:03 rivo nmbd[3067]: [2025/04/14 11:28:03.374492, 0] ../source3/libsmb/nmblib.c:917(send_udp) Apr 14 11:28:03 rivo nmbd[3067]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Apr 14 11:28:03 rivo nmbd[3067]: [2025/04/14 11:28:03.374638, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Apr 14 11:28:03 rivo nmbd[3067]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Apr 14 11:28:03 rivo nmbd[3067]: [2025/04/14 11:28:03.374785, 0] ../source3/libsmb/nmblib.c:917(send_udp) Apr 14 11:28:03 rivo nmbd[3067]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Apr 14 11:28:03 rivo nmbd[3067]: [2025/04/14 11:28:03.374905, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Apr 14 11:28:03 rivo nmbd[3067]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Apr 14 11:28:03 rivo nmbd[3067]: [2025/04/14 11:28:03.375030, 0] ../source3/libsmb/nmblib.c:917(send_udp) Apr 14 11:28:03 rivo nmbd[3067]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Apr 14 11:28:03 rivo nmbd[3067]: [2025/04/14 11:28:03.375147, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Apr 14 11:28:03 rivo nmbd[3067]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Apr 14 11:28:03 rivo nmbd[3067]: [2025/04/14 11:28:03.375281, 0] ../source3/libsmb/nmblib.c:917(send_udp) Apr 14 11:28:03 rivo nmbd[3067]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Apr 14 11:28:03 rivo nmbd[3067]: [2025/04/14 11:28:03.375397, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Apr 14 11:28:03 rivo nmbd[3067]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Apr 14 11:28:03 rivo nmbd[3067]: [2025/04/14 11:28:03.375536, 0] ../source3/libsmb/nmblib.c:917(send_udp) Apr 14 11:28:03 rivo nmbd[3067]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Apr 14 11:28:03 rivo nmbd[3067]: [2025/04/14 11:28:03.375651, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Apr 14 11:28:03 rivo nmbd[3067]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Apr 14 11:28:03 rivo volumio[3116]: info: Moving to next track after playback error Apr 14 11:28:03 rivo volumio[3116]: info: CoreCommandRouter::volumioPlay Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::play index 1 Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::play index undefined Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:03 rivo volumio[3116]: info: CorePlayQueue::getTrack 1 Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::startPlaybackTimer Apr 14 11:28:03 rivo volumio[3116]: info: CorePlayQueue::getTrack 1 Apr 14 11:28:03 rivo volumio[3116]: info: [1744622883422] ControllerQobuz::clearAddPlayTrack Apr 14 11:28:03 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand stop Apr 14 11:28:03 rivo volumio[3116]: info: sendMpdCommand stop took 1 milliseconds Apr 14 11:28:03 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clear Apr 14 11:28:03 rivo volumio[3116]: info: Apr 14 11:28:03 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:03 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:03 rivo volumio[3116]: info: sendMpdCommand clear took 2 milliseconds Apr 14 11:28:03 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/22940095" Apr 14 11:28:03 rivo volumio[3116]: error: updateQueue error: null Apr 14 11:28:03 rivo volumio[3116]: info: ------------------------------ 5ms Apr 14 11:28:03 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940095 Apr 14 11:28:03 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:03 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:03 rivo volumio[3116]: info: getStreamUrl took 106 milliseconds Apr 14 11:28:03 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:03 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:03 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940095" Apr 14 11:28:03 rivo volumio[3116]: info: Apr 14 11:28:03 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:03 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:03 rivo volumio[3116]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940095" took 2 milliseconds Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 14 11:28:03 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand play Apr 14 11:28:03 rivo volumio[3116]: info: ------------------------------ 4ms Apr 14 11:28:03 rivo volumio[3116]: info: sendMpdCommand play took 3 milliseconds Apr 14 11:28:03 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940095 Apr 14 11:28:03 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:03 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:03 rivo volumio[3116]: info: getStreamUrl took 104 milliseconds Apr 14 11:28:03 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:03 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:03 rivo volumio[3116]: info: Apr 14 11:28:03 rivo volumio[3116]: ---------------------------- MPD announces state update: player Apr 14 11:28:03 rivo volumio[3116]: info: ControllerMpd::getState Apr 14 11:28:03 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand status Apr 14 11:28:03 rivo volumio[3116]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 14 11:28:03 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 14 11:28:03 rivo volumio[3116]: info: sendMpdCommand status took 5 milliseconds Apr 14 11:28:03 rivo volumio[3116]: verbose: ControllerMpd::parseState Apr 14 11:28:03 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 11:28:03 rivo volumio[3116]: info: sendMpdCommand clearerror took 3 milliseconds Apr 14 11:28:03 rivo volumio[3116]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 14 11:28:03 rivo volumio[3116]: verbose: ControllerMpd::parseTrackInfo Apr 14 11:28:03 rivo volumio[3116]: info: ControllerMpd::pushState Apr 14 11:28:03 rivo volumio[3116]: info: CoreCommandRouter::servicePushState Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:03 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 11:28:03 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:03 rivo volumio[3116]: info: CorePlayQueue::getTrack 1 Apr 14 11:28:03 rivo volumio[3116]: 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":"22940095","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/22940095","trackType":"qobuz"} Apr 14 11:28:03 rivo volumio[3116]: verbose: CURRENT POSITION 1 Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::syncState stateService stop Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::syncState currentStatus stop Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:03 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:03 rivo volumio[3116]: info: No code Apr 14 11:28:03 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:03 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:03 rivo volumio[3116]: info: ------------------------------ 32ms Apr 14 11:28:03 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:03 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:03 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:03 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:03 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:04 rivo volumio[3116]: info: MYVOLUMIO: Adding device Apr 14 11:28:04 rivo volumio[3116]: info: MYVOLUMIO: Evaluating Server Apr 14 11:28:04 rivo volumio[3116]: info: Moving to next track after playback error Apr 14 11:28:04 rivo volumio[3116]: info: CoreCommandRouter::volumioPlay Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::play index 2 Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::play index undefined Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:04 rivo volumio[3116]: info: CorePlayQueue::getTrack 2 Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::startPlaybackTimer Apr 14 11:28:04 rivo volumio[3116]: info: CorePlayQueue::getTrack 2 Apr 14 11:28:04 rivo volumio[3116]: info: [1744622884701] ControllerQobuz::clearAddPlayTrack Apr 14 11:28:04 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand stop Apr 14 11:28:04 rivo volumio[3116]: info: sendMpdCommand stop took 2 milliseconds Apr 14 11:28:04 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clear Apr 14 11:28:04 rivo volumio[3116]: info: Apr 14 11:28:04 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:04 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:04 rivo volumio[3116]: info: sendMpdCommand clear took 2 milliseconds Apr 14 11:28:04 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/22940096" Apr 14 11:28:04 rivo volumio[3116]: error: updateQueue error: null Apr 14 11:28:04 rivo volumio[3116]: info: ------------------------------ 4ms Apr 14 11:28:04 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940096 Apr 14 11:28:04 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:04 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:04 rivo volumio[3116]: info: getStreamUrl took 95 milliseconds Apr 14 11:28:04 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:04 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:04 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940096" Apr 14 11:28:04 rivo volumio[3116]: info: Apr 14 11:28:04 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:04 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:04 rivo volumio[3116]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940096" took 2 milliseconds Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 14 11:28:04 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand play Apr 14 11:28:04 rivo volumio[3116]: info: ------------------------------ 4ms Apr 14 11:28:04 rivo volumio[3116]: info: sendMpdCommand play took 2 milliseconds Apr 14 11:28:04 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940096 Apr 14 11:28:04 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:04 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:04 rivo volumio[3116]: info: Setting Geolocation for MyVolumio to eu2 Apr 14 11:28:04 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 11:28:04 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 11:28:04 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 11:28:04 rivo volumio[3116]: info: getStreamUrl took 81 milliseconds Apr 14 11:28:04 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:04 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:04 rivo volumio[3116]: info: Apr 14 11:28:04 rivo volumio[3116]: ---------------------------- MPD announces state update: player Apr 14 11:28:04 rivo volumio[3116]: info: ControllerMpd::getState Apr 14 11:28:04 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand status Apr 14 11:28:04 rivo volumio[3116]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 14 11:28:04 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 14 11:28:04 rivo volumio[3116]: info: sendMpdCommand status took 5 milliseconds Apr 14 11:28:04 rivo volumio[3116]: verbose: ControllerMpd::parseState Apr 14 11:28:04 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 11:28:04 rivo volumio[3116]: info: sendMpdCommand clearerror took 3 milliseconds Apr 14 11:28:04 rivo volumio[3116]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 14 11:28:04 rivo volumio[3116]: verbose: ControllerMpd::parseTrackInfo Apr 14 11:28:04 rivo volumio[3116]: info: ControllerMpd::pushState Apr 14 11:28:04 rivo volumio[3116]: info: CoreCommandRouter::servicePushState Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:04 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 11:28:04 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:04 rivo volumio[3116]: info: CorePlayQueue::getTrack 2 Apr 14 11:28:04 rivo volumio[3116]: 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":"22940096","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/22940096","trackType":"qobuz"} Apr 14 11:28:04 rivo volumio[3116]: verbose: CURRENT POSITION 2 Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::syncState stateService stop Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::syncState currentStatus stop Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:04 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:04 rivo volumio[3116]: info: No code Apr 14 11:28:04 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:04 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:04 rivo volumio[3116]: info: ------------------------------ 32ms Apr 14 11:28:04 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:04 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:04 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:04 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:04 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:05 rivo volumio[3116]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 14 11:28:05 rivo volumio[3116]: info: Updating MyVolumio device info Apr 14 11:28:05 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 11:28:05 rivo volumio[3116]: info: Moving to next track after playback error Apr 14 11:28:05 rivo volumio[3116]: info: CoreCommandRouter::volumioPlay Apr 14 11:28:05 rivo volumio[3116]: info: CoreStateMachine::play index 3 Apr 14 11:28:05 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:05 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:05 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:05 rivo volumio[3116]: info: CoreStateMachine::play index undefined Apr 14 11:28:05 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:05 rivo volumio[3116]: info: CorePlayQueue::getTrack 3 Apr 14 11:28:05 rivo volumio[3116]: info: CoreStateMachine::startPlaybackTimer Apr 14 11:28:05 rivo volumio[3116]: info: CorePlayQueue::getTrack 3 Apr 14 11:28:05 rivo volumio[3116]: info: [1744622885946] ControllerQobuz::clearAddPlayTrack Apr 14 11:28:05 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand stop Apr 14 11:28:05 rivo volumio[3116]: info: sendMpdCommand stop took 1 milliseconds Apr 14 11:28:05 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clear Apr 14 11:28:05 rivo volumio[3116]: info: Apr 14 11:28:05 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:05 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:05 rivo volumio[3116]: info: sendMpdCommand clear took 2 milliseconds Apr 14 11:28:05 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/22940097" Apr 14 11:28:05 rivo volumio[3116]: error: updateQueue error: null Apr 14 11:28:05 rivo volumio[3116]: info: ------------------------------ 4ms Apr 14 11:28:05 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940097 Apr 14 11:28:05 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:05 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:06 rivo volumio[3116]: info: getStreamUrl took 97 milliseconds Apr 14 11:28:06 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:06 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:06 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940097" Apr 14 11:28:06 rivo volumio[3116]: info: Apr 14 11:28:06 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:06 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:06 rivo volumio[3116]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940097" took 3 milliseconds Apr 14 11:28:06 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 14 11:28:06 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand play Apr 14 11:28:06 rivo volumio[3116]: info: ------------------------------ 4ms Apr 14 11:28:06 rivo volumio[3116]: info: sendMpdCommand play took 2 milliseconds Apr 14 11:28:06 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940097 Apr 14 11:28:06 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:06 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:06 rivo volumio[3116]: info: getStreamUrl took 90 milliseconds Apr 14 11:28:06 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:06 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:06 rivo volumio[3116]: info: Apr 14 11:28:06 rivo volumio[3116]: ---------------------------- MPD announces state update: player Apr 14 11:28:06 rivo volumio[3116]: info: ControllerMpd::getState Apr 14 11:28:06 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand status Apr 14 11:28:06 rivo volumio[3116]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 14 11:28:06 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 14 11:28:06 rivo volumio[3116]: info: sendMpdCommand status took 5 milliseconds Apr 14 11:28:06 rivo volumio[3116]: verbose: ControllerMpd::parseState Apr 14 11:28:06 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 11:28:06 rivo volumio[3116]: info: sendMpdCommand clearerror took 3 milliseconds Apr 14 11:28:06 rivo volumio[3116]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 14 11:28:06 rivo volumio[3116]: verbose: ControllerMpd::parseTrackInfo Apr 14 11:28:06 rivo volumio[3116]: info: ControllerMpd::pushState Apr 14 11:28:06 rivo volumio[3116]: info: CoreCommandRouter::servicePushState Apr 14 11:28:06 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:06 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 11:28:06 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:06 rivo volumio[3116]: info: CorePlayQueue::getTrack 3 Apr 14 11:28:06 rivo volumio[3116]: 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":"22940097","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/22940097","trackType":"qobuz"} Apr 14 11:28:06 rivo volumio[3116]: verbose: CURRENT POSITION 3 Apr 14 11:28:06 rivo volumio[3116]: info: CoreStateMachine::syncState stateService stop Apr 14 11:28:06 rivo volumio[3116]: info: CoreStateMachine::syncState currentStatus stop Apr 14 11:28:06 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:06 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:06 rivo volumio[3116]: info: No code Apr 14 11:28:06 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:06 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:06 rivo volumio[3116]: info: ------------------------------ 31ms Apr 14 11:28:06 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:06 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:06 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:06 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:06 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:06 rivo volumio[3116]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 14 11:28:07 rivo volumio[3116]: info: Moving to next track after playback error Apr 14 11:28:07 rivo volumio[3116]: info: CoreCommandRouter::volumioPlay Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::play index 4 Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::play index undefined Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:07 rivo volumio[3116]: info: CorePlayQueue::getTrack 4 Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::startPlaybackTimer Apr 14 11:28:07 rivo volumio[3116]: info: CorePlayQueue::getTrack 4 Apr 14 11:28:07 rivo volumio[3116]: info: [1744622887203] ControllerQobuz::clearAddPlayTrack Apr 14 11:28:07 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand stop Apr 14 11:28:07 rivo volumio[3116]: info: sendMpdCommand stop took 1 milliseconds Apr 14 11:28:07 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clear Apr 14 11:28:07 rivo volumio[3116]: info: Apr 14 11:28:07 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:07 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:07 rivo volumio[3116]: info: sendMpdCommand clear took 2 milliseconds Apr 14 11:28:07 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/22940098" Apr 14 11:28:07 rivo volumio[3116]: error: updateQueue error: null Apr 14 11:28:07 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940098 Apr 14 11:28:07 rivo volumio[3116]: info: ------------------------------ 8ms Apr 14 11:28:07 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:07 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:07 rivo volumio[3116]: info: getStreamUrl took 85 milliseconds Apr 14 11:28:07 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:07 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:07 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940098" Apr 14 11:28:07 rivo volumio[3116]: info: Apr 14 11:28:07 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:07 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:07 rivo volumio[3116]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940098" took 2 milliseconds Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 14 11:28:07 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand play Apr 14 11:28:07 rivo volumio[3116]: info: ------------------------------ 4ms Apr 14 11:28:07 rivo volumio[3116]: info: sendMpdCommand play took 2 milliseconds Apr 14 11:28:07 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940098 Apr 14 11:28:07 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:07 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:07 rivo volumio[3116]: info: getStreamUrl took 85 milliseconds Apr 14 11:28:07 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:07 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:07 rivo volumio[3116]: info: Apr 14 11:28:07 rivo volumio[3116]: ---------------------------- MPD announces state update: player Apr 14 11:28:07 rivo volumio[3116]: info: ControllerMpd::getState Apr 14 11:28:07 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand status Apr 14 11:28:07 rivo volumio[3116]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 14 11:28:07 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 14 11:28:07 rivo volumio[3116]: info: sendMpdCommand status took 6 milliseconds Apr 14 11:28:07 rivo volumio[3116]: verbose: ControllerMpd::parseState Apr 14 11:28:07 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 11:28:07 rivo volumio[3116]: info: sendMpdCommand clearerror took 3 milliseconds Apr 14 11:28:07 rivo volumio[3116]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 14 11:28:07 rivo volumio[3116]: verbose: ControllerMpd::parseTrackInfo Apr 14 11:28:07 rivo volumio[3116]: info: ControllerMpd::pushState Apr 14 11:28:07 rivo volumio[3116]: info: CoreCommandRouter::servicePushState Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:07 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 11:28:07 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:07 rivo volumio[3116]: info: CorePlayQueue::getTrack 4 Apr 14 11:28:07 rivo volumio[3116]: 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":"22940098","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/22940098","trackType":"qobuz"} Apr 14 11:28:07 rivo volumio[3116]: verbose: CURRENT POSITION 4 Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::syncState stateService stop Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::syncState currentStatus stop Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:07 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:07 rivo volumio[3116]: info: No code Apr 14 11:28:07 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:07 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:07 rivo volumio[3116]: info: ------------------------------ 31ms Apr 14 11:28:07 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:07 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:07 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:07 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:07 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:08 rivo volumio[3116]: info: Moving to next track after playback error Apr 14 11:28:08 rivo volumio[3116]: info: CoreCommandRouter::volumioPlay Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::play index 5 Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::play index undefined Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:08 rivo volumio[3116]: info: CorePlayQueue::getTrack 5 Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::startPlaybackTimer Apr 14 11:28:08 rivo volumio[3116]: info: CorePlayQueue::getTrack 5 Apr 14 11:28:08 rivo volumio[3116]: info: [1744622888439] ControllerQobuz::clearAddPlayTrack Apr 14 11:28:08 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand stop Apr 14 11:28:08 rivo volumio[3116]: info: sendMpdCommand stop took 1 milliseconds Apr 14 11:28:08 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clear Apr 14 11:28:08 rivo volumio[3116]: info: Apr 14 11:28:08 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:08 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:08 rivo volumio[3116]: info: sendMpdCommand clear took 2 milliseconds Apr 14 11:28:08 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/22940099" Apr 14 11:28:08 rivo volumio[3116]: error: updateQueue error: null Apr 14 11:28:08 rivo volumio[3116]: info: ------------------------------ 4ms Apr 14 11:28:08 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940099 Apr 14 11:28:08 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:08 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:08 rivo volumio[3116]: info: CoreCommandRouter::volumioGetQueue Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::getQueue Apr 14 11:28:08 rivo volumio[3116]: info: CorePlayQueue::getQueue Apr 14 11:28:08 rivo volumio[3116]: info: Executing endpoint metavolumio Apr 14 11:28:08 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 14 11:28:08 rivo volumio[3116]: info: Executing endpoint metavolumio Apr 14 11:28:08 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 14 11:28:08 rivo volumio[3116]: info: getStreamUrl took 95 milliseconds Apr 14 11:28:08 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:08 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:08 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940099" Apr 14 11:28:08 rivo volumio[3116]: info: Apr 14 11:28:08 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:08 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:08 rivo volumio[3116]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940099" took 2 milliseconds Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 14 11:28:08 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand play Apr 14 11:28:08 rivo volumio[3116]: info: ------------------------------ 8ms Apr 14 11:28:08 rivo volumio[3116]: info: sendMpdCommand play took 3 milliseconds Apr 14 11:28:08 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940099 Apr 14 11:28:08 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:08 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:08 rivo volumio[3116]: info: getStreamUrl took 84 milliseconds Apr 14 11:28:08 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:08 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:08 rivo volumio[3116]: info: Apr 14 11:28:08 rivo volumio[3116]: ---------------------------- MPD announces state update: player Apr 14 11:28:08 rivo volumio[3116]: info: ControllerMpd::getState Apr 14 11:28:08 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand status Apr 14 11:28:08 rivo volumio[3116]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 14 11:28:08 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 14 11:28:08 rivo volumio[3116]: info: sendMpdCommand status took 6 milliseconds Apr 14 11:28:08 rivo volumio[3116]: verbose: ControllerMpd::parseState Apr 14 11:28:08 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 11:28:08 rivo volumio[3116]: info: sendMpdCommand clearerror took 3 milliseconds Apr 14 11:28:08 rivo volumio[3116]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 14 11:28:08 rivo volumio[3116]: verbose: ControllerMpd::parseTrackInfo Apr 14 11:28:08 rivo volumio[3116]: info: ControllerMpd::pushState Apr 14 11:28:08 rivo volumio[3116]: info: CoreCommandRouter::servicePushState Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:08 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 11:28:08 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:08 rivo volumio[3116]: info: CorePlayQueue::getTrack 5 Apr 14 11:28:08 rivo volumio[3116]: 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":"22940099","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/22940099","trackType":"qobuz"} Apr 14 11:28:08 rivo volumio[3116]: verbose: CURRENT POSITION 5 Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::syncState stateService stop Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::syncState currentStatus stop Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:08 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:08 rivo volumio[3116]: info: No code Apr 14 11:28:08 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:08 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:08 rivo volumio[3116]: info: ------------------------------ 31ms Apr 14 11:28:08 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:08 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:08 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:08 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:08 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:09 rivo volumio[3116]: info: Moving to next track after playback error Apr 14 11:28:09 rivo volumio[3116]: info: CoreCommandRouter::volumioPlay Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::play index 6 Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::play index undefined Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:09 rivo volumio[3116]: info: CorePlayQueue::getTrack 6 Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::startPlaybackTimer Apr 14 11:28:09 rivo volumio[3116]: info: CorePlayQueue::getTrack 6 Apr 14 11:28:09 rivo volumio[3116]: info: [1744622889691] ControllerQobuz::clearAddPlayTrack Apr 14 11:28:09 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand stop Apr 14 11:28:09 rivo volumio[3116]: info: sendMpdCommand stop took 1 milliseconds Apr 14 11:28:09 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clear Apr 14 11:28:09 rivo volumio[3116]: info: Apr 14 11:28:09 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:09 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:09 rivo volumio[3116]: info: sendMpdCommand clear took 2 milliseconds Apr 14 11:28:09 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/22940100" Apr 14 11:28:09 rivo volumio[3116]: error: updateQueue error: null Apr 14 11:28:09 rivo volumio[3116]: info: ------------------------------ 4ms Apr 14 11:28:09 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940100 Apr 14 11:28:09 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:09 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:09 rivo volumio[3116]: info: getStreamUrl took 93 milliseconds Apr 14 11:28:09 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:09 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:09 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940100" Apr 14 11:28:09 rivo volumio[3116]: info: Apr 14 11:28:09 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:09 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:09 rivo volumio[3116]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940100" took 2 milliseconds Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 14 11:28:09 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand play Apr 14 11:28:09 rivo volumio[3116]: info: ------------------------------ 4ms Apr 14 11:28:09 rivo volumio[3116]: info: sendMpdCommand play took 2 milliseconds Apr 14 11:28:09 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940100 Apr 14 11:28:09 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:09 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:09 rivo volumio[3116]: info: getStreamUrl took 109 milliseconds Apr 14 11:28:09 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:09 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:09 rivo volumio[3116]: info: Apr 14 11:28:09 rivo volumio[3116]: ---------------------------- MPD announces state update: player Apr 14 11:28:09 rivo volumio[3116]: info: ControllerMpd::getState Apr 14 11:28:09 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand status Apr 14 11:28:09 rivo volumio[3116]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 14 11:28:09 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 14 11:28:09 rivo volumio[3116]: info: sendMpdCommand status took 6 milliseconds Apr 14 11:28:09 rivo volumio[3116]: verbose: ControllerMpd::parseState Apr 14 11:28:09 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 11:28:09 rivo volumio[3116]: info: sendMpdCommand clearerror took 2 milliseconds Apr 14 11:28:09 rivo volumio[3116]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 14 11:28:09 rivo volumio[3116]: verbose: ControllerMpd::parseTrackInfo Apr 14 11:28:09 rivo volumio[3116]: info: ControllerMpd::pushState Apr 14 11:28:09 rivo volumio[3116]: info: CoreCommandRouter::servicePushState Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:09 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 11:28:09 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:09 rivo volumio[3116]: info: CorePlayQueue::getTrack 6 Apr 14 11:28:09 rivo volumio[3116]: 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":"22940100","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/22940100","trackType":"qobuz"} Apr 14 11:28:09 rivo volumio[3116]: verbose: CURRENT POSITION 6 Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::syncState stateService stop Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::syncState currentStatus stop Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:09 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:09 rivo volumio[3116]: info: No code Apr 14 11:28:09 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:09 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:09 rivo volumio[3116]: info: ------------------------------ 36ms Apr 14 11:28:09 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:09 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:09 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:09 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:09 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:10 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 14 11:28:10 rivo volumio[3116]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 14 11:28:10 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 14 11:28:10 rivo volumio[3116]: info: Received Get System Version Apr 14 11:28:10 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 14 11:28:10 rivo volumio[3116]: info: Received Get System Info Apr 14 11:28:10 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 11:28:10 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 11:28:10 rivo volumio[3116]: info: Discovery: Getting this device information Apr 14 11:28:10 rivo volumio[3116]: info: CoreCommandRouter::volumioGetState Apr 14 11:28:10 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 11:28:10 rivo volumio[3116]: info: Moving to next track after playback error Apr 14 11:28:10 rivo volumio[3116]: info: CoreCommandRouter::volumioPlay Apr 14 11:28:10 rivo volumio[3116]: info: CoreStateMachine::play index 7 Apr 14 11:28:10 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:10 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:10 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:10 rivo volumio[3116]: info: CoreStateMachine::play index undefined Apr 14 11:28:10 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:10 rivo volumio[3116]: info: CorePlayQueue::getTrack 7 Apr 14 11:28:10 rivo volumio[3116]: info: CoreStateMachine::startPlaybackTimer Apr 14 11:28:10 rivo volumio[3116]: info: CorePlayQueue::getTrack 7 Apr 14 11:28:10 rivo volumio[3116]: info: [1744622890957] ControllerQobuz::clearAddPlayTrack Apr 14 11:28:10 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand stop Apr 14 11:28:10 rivo volumio[3116]: info: sendMpdCommand stop took 1 milliseconds Apr 14 11:28:10 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clear Apr 14 11:28:10 rivo volumio[3116]: info: Apr 14 11:28:10 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:10 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:10 rivo volumio[3116]: info: sendMpdCommand clear took 3 milliseconds Apr 14 11:28:10 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/22940101" Apr 14 11:28:10 rivo volumio[3116]: error: updateQueue error: null Apr 14 11:28:10 rivo volumio[3116]: info: ------------------------------ 4ms Apr 14 11:28:10 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940101 Apr 14 11:28:10 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:10 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:11 rivo volumio[3116]: info: getStreamUrl took 103 milliseconds Apr 14 11:28:11 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:11 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:11 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940101" Apr 14 11:28:11 rivo volumio[3116]: info: Apr 14 11:28:11 rivo volumio[3116]: ---------------------------- MPD announces system playlist update Apr 14 11:28:11 rivo volumio[3116]: info: Ignoring MPD Status Update Apr 14 11:28:11 rivo volumio[3116]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/22940101" took 2 milliseconds Apr 14 11:28:11 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 14 11:28:11 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand play Apr 14 11:28:11 rivo volumio[3116]: info: ------------------------------ 4ms Apr 14 11:28:11 rivo volumio[3116]: info: sendMpdCommand play took 2 milliseconds Apr 14 11:28:11 rivo volumio[3116]: STREAMING PROXY: Handling url /?data=qobuz://song/22940101 Apr 14 11:28:11 rivo volumio[3116]: info: Executing endpoint getStreamUrlqobuz Apr 14 11:28:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 14 11:28:11 rivo volumio[3116]: info: getStreamUrl took 83 milliseconds Apr 14 11:28:11 rivo volumio[3116]: error: Could not get QOBUZ Stream URL: [object Object] Apr 14 11:28:11 rivo volumio[3116]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get QOBUZ Stream URL: [object Object]"} Apr 14 11:28:11 rivo volumio[3116]: info: Apr 14 11:28:11 rivo volumio[3116]: ---------------------------- MPD announces state update: player Apr 14 11:28:11 rivo volumio[3116]: info: ControllerMpd::getState Apr 14 11:28:11 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand status Apr 14 11:28:11 rivo volumio[3116]: error: MPD Playback Error: Failed to decode stream, moving to next track Apr 14 11:28:11 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 14 11:28:11 rivo volumio[3116]: info: sendMpdCommand status took 5 milliseconds Apr 14 11:28:11 rivo volumio[3116]: verbose: ControllerMpd::parseState Apr 14 11:28:11 rivo volumio[3116]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 11:28:11 rivo volumio[3116]: info: sendMpdCommand clearerror took 3 milliseconds Apr 14 11:28:11 rivo volumio[3116]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 14 11:28:11 rivo volumio[3116]: verbose: ControllerMpd::parseTrackInfo Apr 14 11:28:11 rivo volumio[3116]: info: ControllerMpd::pushState Apr 14 11:28:11 rivo volumio[3116]: info: CoreCommandRouter::servicePushState Apr 14 11:28:11 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 11:28:11 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:11 rivo volumio[3116]: info: CorePlayQueue::getTrack 7 Apr 14 11:28:11 rivo volumio[3116]: 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":"22940101","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/22940101","trackType":"qobuz"} Apr 14 11:28:11 rivo volumio[3116]: verbose: CURRENT POSITION 7 Apr 14 11:28:11 rivo volumio[3116]: info: CoreStateMachine::syncState stateService stop Apr 14 11:28:11 rivo volumio[3116]: info: CoreStateMachine::syncState currentStatus stop Apr 14 11:28:11 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:11 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:11 rivo volumio[3116]: info: No code Apr 14 11:28:11 rivo volumio[3116]: info: CoreStateMachine::pushState Apr 14 11:28:11 rivo volumio[3116]: info: CoreCommandRouter::volumioPushState Apr 14 11:28:11 rivo volumio[3116]: info: ------------------------------ 31ms Apr 14 11:28:11 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:11 rivo volumio[3116]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Apr 14 11:28:11 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:11 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:11 rivo volumio[3116]: info: Updating RAAT Signal Path Apr 14 11:28:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 14 11:28:11 rivo volumio[3116]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 14 11:28:11 rivo volumio[3116]: info: CoreCommandRouter::volumioGetState Apr 14 11:28:12 rivo volumio[3116]: info: Preload queue cleared Apr 14 11:28:12 rivo volumio[3116]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::ClearQueue Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:12 rivo volumio[3116]: info: CorePlayQueue::clearPlayQueue Apr 14 11:28:12 rivo volumio[3116]: info: CorePlayQueue::saveQueue Apr 14 11:28:12 rivo volumio[3116]: info: CoreCommandRouter::volumioPushQueue Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::addQueueItems Apr 14 11:28:12 rivo volumio[3116]: info: CorePlayQueue::addQueueItems Apr 14 11:28:12 rivo volumio[3116]: info: Preload queue cleared Apr 14 11:28:12 rivo volumio[3116]: info: Adding Item to queue: qobuz://album/0881969248678 Apr 14 11:28:12 rivo volumio[3116]: info: Exploding uri qobuz://album/0881969248678 in service qobuz Apr 14 11:28:12 rivo volumio[3116]: https://prod.vlmapi.io/v2/qobuz/explodeUri Apr 14 11:28:12 rivo volumio[3116]: info: explodeUri took 91 milliseconds Apr 14 11:28:12 rivo volumio[3116]: error: QOBUZ Browse Error: Unauthorized Apr 14 11:28:12 rivo volumio[3116]: error: Commandrouter: Cannot explode uri qobuz://album/0881969248678 from service qobuz: Unauthorized Apr 14 11:28:12 rivo volumio[3116]: info: CoreCommandRouter::volumioPushQueue Apr 14 11:28:12 rivo volumio[3116]: info: CorePlayQueue::saveQueue Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::updateTrackBlock Apr 14 11:28:12 rivo volumio[3116]: info: CorePlayQueue::getTrackBlock Apr 14 11:28:12 rivo volumio[3116]: info: CoreCommandRouter::volumioPlay Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::play index 0 Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::play index undefined Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:12 rivo volumio[3116]: info: CorePlayQueue::getTrack 0 Apr 14 11:28:12 rivo volumio[3116]: info: Moving to next track after playback error Apr 14 11:28:12 rivo volumio[3116]: info: CoreCommandRouter::volumioPlay Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::play index 1 Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::play index undefined Apr 14 11:28:12 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:12 rivo volumio[3116]: info: CorePlayQueue::getTrack 1 Apr 14 11:28:16 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 11:28:16 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 14 11:28:16 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 14 11:28:16 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 14 11:28:16 rivo volumio[3116]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 11:28:16 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 14 11:28:18 rivo volumio[3116]: info: Preload queue cleared Apr 14 11:28:18 rivo volumio[3116]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 14 11:28:18 rivo volumio[3116]: info: CoreStateMachine::ClearQueue Apr 14 11:28:18 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:18 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:18 rivo volumio[3116]: info: CorePlayQueue::clearPlayQueue Apr 14 11:28:18 rivo volumio[3116]: info: CorePlayQueue::saveQueue Apr 14 11:28:18 rivo volumio[3116]: info: CoreCommandRouter::volumioPushQueue Apr 14 11:28:18 rivo volumio[3116]: info: CoreStateMachine::addQueueItems Apr 14 11:28:18 rivo volumio[3116]: info: CorePlayQueue::addQueueItems Apr 14 11:28:18 rivo volumio[3116]: info: Preload queue cleared Apr 14 11:28:18 rivo volumio[3116]: info: Adding Item to queue: qobuz://album/0881969248678 Apr 14 11:28:18 rivo volumio[3116]: info: Exploding uri qobuz://album/0881969248678 in service qobuz Apr 14 11:28:18 rivo volumio[3116]: https://prod.vlmapi.io/v2/qobuz/explodeUri Apr 14 11:28:18 rivo volumio[3116]: info: explodeUri took 96 milliseconds Apr 14 11:28:18 rivo volumio[3116]: error: QOBUZ Browse Error: Unauthorized Apr 14 11:28:18 rivo volumio[3116]: error: Commandrouter: Cannot explode uri qobuz://album/0881969248678 from service qobuz: Unauthorized Apr 14 11:28:18 rivo volumio[3116]: info: CoreCommandRouter::volumioPushQueue Apr 14 11:28:18 rivo volumio[3116]: info: CorePlayQueue::saveQueue Apr 14 11:28:18 rivo volumio[3116]: info: CoreStateMachine::updateTrackBlock Apr 14 11:28:18 rivo volumio[3116]: info: CorePlayQueue::getTrackBlock Apr 14 11:28:18 rivo volumio[3116]: info: CoreCommandRouter::volumioPlay Apr 14 11:28:18 rivo volumio[3116]: info: CoreStateMachine::play index 0 Apr 14 11:28:18 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:18 rivo volumio[3116]: info: CoreStateMachine::stop Apr 14 11:28:18 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:18 rivo volumio[3116]: info: CoreStateMachine::play index undefined Apr 14 11:28:18 rivo volumio[3116]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 11:28:18 rivo volumio[3116]: info: CorePlayQueue::getTrack 0 Apr 14 11:28:26 rivo systemd[1]: systemd-timedated.service: Succeeded. Apr 14 11:28:29 rivo volumio[3116]: info: Executing endpoint getSimilarArtists Apr 14 11:28:29 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Apr 14 11:28:29 rivo volumio[3116]: info: Executing endpoint metavolumio Apr 14 11:28:29 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 14 11:28:39 rivo volumio[3116]: info: Executing endpoint getSimilarArtists Apr 14 11:28:39 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Apr 14 11:28:39 rivo volumio[3116]: info: Executing endpoint metavolumio Apr 14 11:28:39 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 14 11:28:42 rivo volumio[3116]: info: Executing endpoint getSimilarArtists Apr 14 11:28:42 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Apr 14 11:28:43 rivo volumio[3116]: info: Executing endpoint metavolumio Apr 14 11:28:43 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 14 11:29:07 rivo volumio[3116]: info: CoreCommandRouter::volumioGetState Apr 14 11:29:07 rivo volumio[3116]: info: CorePlayQueue::getTrack 0 Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:11 rivo volumio[3116]: info: Retrieving Cloud Streaming UI Apr 14 11:29:11 rivo volumio[3116]: info: Getting Tidal Cloud Configuration Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:11 rivo volumio[3116]: info: Getting Qobuz Cloud Configuration Apr 14 11:29:11 rivo volumio[3116]: info: Asking plugin for UI Config Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:11 rivo volumio[3116]: info: Getting Spotify Cloud Configuration Apr 14 11:29:11 rivo volumio[3116]: info: Asking plugin for UI Config Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:11 rivo volumio[3116]: info: Saving Spotify Acccount Apr 14 11:29:11 rivo volumio[3116]: info: Got it Apr 14 11:29:11 rivo volumio[3116]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 14 11:29:11 rivo volumio[3116]: info: Got Tidal Cloud Configuration Apr 14 11:29:11 rivo volumio[3116]: info: Got it Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 11:29:11 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 14 11:29:15 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 11:29:19 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 11:29:21 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Apr 14 11:29:22 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 14 11:29:23 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 11:29:25 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Apr 14 11:29:26 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 14 11:29:27 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 11:29:31 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 11:29:46 rivo volumio[3116]: info: Received OAUTH Data Apr 14 11:29:46 rivo volumio[3116]: info: Refreshing QOBUZ token Apr 14 11:29:46 rivo volumio[3116]: info: Access Token successfully retrieved Apr 14 11:29:46 rivo volumio[3116]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 14 11:29:46 rivo volumio[3116]: info: [1744622986698] CoreMusicLibrary::Adding element QOBUZ Apr 14 11:29:46 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 14 11:29:46 rivo volumio[3116]: Cannot find translation for source QOBUZ Apr 14 11:29:46 rivo sudo[4970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 14 11:29:46 rivo sudo[4970]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 11:29:46 rivo sudo[4970]: pam_unix(sudo:session): session closed for user root Apr 14 11:29:46 rivo sudo[4973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 11:29:46 rivo sudo[4973]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 11:29:46 rivo sudo[4973]: pam_unix(sudo:session): session closed for user root Apr 14 11:29:46 rivo volumio[3116]: verbose: New Socket.io Connection to 192.168.178.55 from 192.168.178.26 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::volumioGetVisibleSources Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::volumioGetState Apr 14 11:29:47 rivo volumio[3116]: info: CorePlayQueue::getTrack 0 Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:47 rivo volumio[3116]: info: Retrieving Cloud Streaming UI Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 14 11:29:47 rivo volumio[3116]: info: Received Get System Info Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 11:29:47 rivo volumio[3116]: info: Discovery: Getting this device information Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::volumioGetState Apr 14 11:29:47 rivo volumio[3116]: info: CorePlayQueue::getTrack 0 Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::volumioGetState Apr 14 11:29:47 rivo volumio[3116]: info: CorePlayQueue::getTrack 0 Apr 14 11:29:47 rivo volumio[3116]: info: Listing playlists Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 14 11:29:47 rivo volumio[3116]: info: Getting Tidal Cloud Configuration Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:47 rivo volumio[3116]: info: Getting Qobuz Cloud Configuration Apr 14 11:29:47 rivo volumio[3116]: info: Asking plugin for UI Config Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:47 rivo volumio[3116]: info: Getting Spotify Cloud Configuration Apr 14 11:29:47 rivo volumio[3116]: info: Asking plugin for UI Config Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:47 rivo volumio[3116]: info: Saving Spotify Acccount Apr 14 11:29:47 rivo volumio[3116]: info: Got it Apr 14 11:29:47 rivo volumio[3116]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 14 11:29:47 rivo volumio[3116]: info: Got Tidal Cloud Configuration Apr 14 11:29:47 rivo volumio[3116]: info: Got it Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 11:29:47 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 14 11:29:48 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 14 11:29:48 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 14 11:29:48 rivo volumio[3116]: info: Received Get System Info Apr 14 11:29:48 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 11:29:48 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 11:29:48 rivo volumio[3116]: info: Discovery: Getting this device information Apr 14 11:29:48 rivo volumio[3116]: info: CoreCommandRouter::volumioGetState Apr 14 11:29:48 rivo volumio[3116]: info: CorePlayQueue::getTrack 0 Apr 14 11:29:48 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 11:29:49 rivo sudo[4223]: pam_unix(sudo:session): session closed for user root Apr 14 11:29:49 rivo volumio[3116]: info: Cannot mount NAS NAS-Musik at system boot, trial number 3 ,retrying in 5 seconds Apr 14 11:29:49 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 14 11:29:49 rivo volumio[3116]: info: Received Get System Info Apr 14 11:29:49 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 11:29:49 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 11:29:49 rivo volumio[3116]: info: Discovery: Getting this device information Apr 14 11:29:49 rivo volumio[3116]: info: CoreCommandRouter::volumioGetState Apr 14 11:29:49 rivo volumio[3116]: info: CorePlayQueue::getTrack 0 Apr 14 11:29:49 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 11:29:51 rivo volumio[3116]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 11:29:54 rivo volumio[3116]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 11:29:54 rivo volumio[3116]: TypeError: Cannot read property 'replace' of undefined Apr 14 11:29:54 rivo volumio[3116]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Apr 14 11:29:54 rivo volumio[3116]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Apr 14 11:29:54 rivo volumio[3116]: at listOnTimeout (internal/timers.js:557:17) Apr 14 11:29:54 rivo volumio[3116]: at processTimers (internal/timers.js:500:7) Apr 14 11:29:54 rivo volumio[3116]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 11:29:54 rivo sudo[5003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-14 11:28 Apr 14 11:29:54 rivo sudo[5003]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 08:01:39 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="71b19b3a3eb3d257ef93eee35eba5cf1"