-- Logs begin at Sat 2025-05-03 17:26:46 CST, end at Sat 2025-05-03 17:55:51 CST. -- May 03 17:54:07 volumio volumio-remote-updater[640]: /bin/rm: cannot remove '/data/volumio_factory.sqsh': No such file or directory May 03 17:54:12 volumio volumio-remote-updater[640]: PROGRESS: 95, STATUS: "Finalizing update", ETA: "30s" May 03 17:54:12 volumio volumio-remote-updater[640]: PROGRESS: 100, STATUS: "success", MESSAGE: "Successfully updated to \"3.804\" version. System restart required." May 03 17:54:12 volumio volumio-remote-updater[640]: No test mode May 03 17:54:12 volumio volumio-remote-updater[640]: No alpha test mode May 03 17:54:13 volumio volumio-remote-updater[640]: [2025-05-03 09:54:13] [disconnect] Disconnect close local:[1000] remote:[1000] May 03 17:54:13 volumio volumio-remote-updater[640]: [2025-05-03 09:54:13] [info] asio async_write error: system:32 (Broken pipe) May 03 17:54:13 volumio volumio-remote-updater[640]: [2025-05-03 09:54:13] [fatal] handle_write_frame error: websocketpp.transport:2 (Underlying Transport Error) May 03 17:54:13 volumio systemd[1]: volumio-remote-updater.service: Succeeded. May 03 17:54:13 volumio systemd[1]: volumio-remote-updater.service: Service RestartSec=100ms expired, scheduling restart. May 03 17:54:13 volumio systemd[1]: volumio-remote-updater.service: Scheduled restart job, restart counter is at 1. May 03 17:54:13 volumio systemd[1]: Stopped volumio-remote-updater.service. May 03 17:54:13 volumio systemd[1]: Started volumio-remote-updater.service. May 03 17:54:13 volumio volumio-remote-updater[7519]: Error: No active session May 03 17:54:13 volumio volumio-remote-updater[7519]: [2025-05-03 17:54:13] [connect] Successful connection May 03 17:54:13 volumio volumio-remote-updater[7519]: [2025-05-03 17:54:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1746266053 101 May 03 17:54:13 volumio volumio[6685]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 May 03 17:54:18 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: webradio , addMyWebRadio May 03 17:54:18 volumio volumio[6685]: info: {"name":"台湾之音","uri":"https://streamak0138.akamaized.net/live0138lh-mbm9/_definst_/rti3/chunklist.m3u8"} May 03 17:54:18 volumio volumio[6685]: info: Saving local item my-web-radio May 03 17:54:18 volumio volumio[6685]: info: Saving local item my-web-radio May 03 17:54:21 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 03 17:54:21 volumio volumio[6685]: info: Preload queue cleared May 03 17:54:24 volumio volumio[6685]: info: Preload queue cleared May 03 17:54:24 volumio volumio[6685]: info: CoreCommandRouter::volumioReplaceandPlayItems May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::ClearQueue May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::stop May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::stPlaybackTimer May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::updateTrackBlock May 03 17:54:24 volumio volumio[6685]: info: CorePlayQueue::getTrackBlock May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:54:24 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:24 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 17:54:24 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::serviceStop May 03 17:54:24 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:24 volumio volumio[6685]: info: CoreCommandRouter::serviceStop May 03 17:54:24 volumio volumio[6685]: info: [1746266064024] ControllerWebradio::stop May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand stop May 03 17:54:24 volumio volumio[6685]: info: CorePlayQueue::clearPlayQueue May 03 17:54:24 volumio volumio[6685]: info: CorePlayQueue::saveQueue May 03 17:54:24 volumio volumio[6685]: info: CoreCommandRouter::volumioPushQueue May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::addQueueItems May 03 17:54:24 volumio volumio[6685]: info: CorePlayQueue::addQueueItems May 03 17:54:24 volumio volumio[6685]: info: Preload queue cleared May 03 17:54:24 volumio volumio[6685]: info: Adding Item to queue: https://streamak0138.akamaized.net/live0138lh-mbm9/_definst_/rti3/chunklist.m3u8 May 03 17:54:24 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 03 17:54:24 volumio volumio[6685]: info: CoreCommandRouter::volumioPushQueue May 03 17:54:24 volumio volumio[6685]: info: CorePlayQueue::saveQueue May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::updateTrackBlock May 03 17:54:24 volumio volumio[6685]: info: CorePlayQueue::getTrackBlock May 03 17:54:24 volumio volumio[6685]: info: CoreCommandRouter::volumioPlay May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::play index 0 May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::stop May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::play index undefined May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 17:54:24 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::startPlaybackTimer May 03 17:54:24 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:24 volumio volumio[6685]: info: [1746266064042] ControllerWebradio::clearAddPlayTrack May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand stop May 03 17:54:24 volumio volumio[6685]: info: May 03 17:54:24 volumio volumio[6685]: ---------------------------- MPD announces state update: player May 03 17:54:24 volumio volumio[6685]: info: sendMpdCommand stop took 23 milliseconds May 03 17:54:24 volumio volumio[6685]: info: ControllerMpd::getState May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand status May 03 17:54:24 volumio volumio[6685]: info: May 03 17:54:24 volumio volumio[6685]: ---------------------------- MPD announces state update: player May 03 17:54:24 volumio volumio[6685]: info: ControllerMpd::getState May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand status May 03 17:54:24 volumio volumio[6685]: info: May 03 17:54:24 volumio volumio[6685]: ---------------------------- MPD announces state update: player May 03 17:54:24 volumio volumio[6685]: info: ControllerMpd::getState May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand status May 03 17:54:24 volumio volumio[6685]: info: sendMpdCommand stop took 10 milliseconds May 03 17:54:24 volumio volumio[6685]: info: sendMpdCommand status took 6 milliseconds May 03 17:54:24 volumio volumio[6685]: info: sendMpdCommand status took 5 milliseconds May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand clear May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::parseState May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::parseState May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 17:54:24 volumio volumio[6685]: info: May 03 17:54:24 volumio volumio[6685]: ---------------------------- MPD announces system playlist update May 03 17:54:24 volumio volumio[6685]: info: Ignoring MPD Status Update May 03 17:54:24 volumio volumio[6685]: info: sendMpdCommand status took 10 milliseconds May 03 17:54:24 volumio volumio[6685]: info: sendMpdCommand clear took 6 milliseconds May 03 17:54:24 volumio volumio[6685]: info: sendMpdCommand playlistinfo took 6 milliseconds May 03 17:54:24 volumio volumio[6685]: info: sendMpdCommand playlistinfo took 6 milliseconds May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::parseState May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand add "https://streamak0138.akamaized.net/live0138lh-mbm9/_definst_/rti3/chunklist.m3u8" May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::parseTrackInfo May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::parseTrackInfo May 03 17:54:24 volumio volumio[6685]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 03 17:54:24 volumio volumio[6685]: info: ------------------------------ 20ms May 03 17:54:24 volumio volumio[6685]: info: ------------------------------ 19ms May 03 17:54:24 volumio volumio[6685]: info: May 03 17:54:24 volumio volumio[6685]: ---------------------------- MPD announces system playlist update May 03 17:54:24 volumio volumio[6685]: info: Ignoring MPD Status Update May 03 17:54:24 volumio volumio[6685]: info: May 03 17:54:24 volumio volumio[6685]: ---------------------------- MPD announces system playlist update May 03 17:54:24 volumio volumio[6685]: info: Ignoring MPD Status Update May 03 17:54:24 volumio volumio[6685]: error: updateQueue error: null May 03 17:54:24 volumio volumio[6685]: info: May 03 17:54:24 volumio volumio[6685]: ---------------------------- MPD announces system playlist update May 03 17:54:24 volumio volumio[6685]: info: Ignoring MPD Status Update May 03 17:54:24 volumio volumio[6685]: info: ------------------------------ 10ms May 03 17:54:24 volumio volumio[6685]: info: sendMpdCommand playlistinfo took 9 milliseconds May 03 17:54:24 volumio volumio[6685]: info: sendMpdCommand add "https://streamak0138.akamaized.net/live0138lh-mbm9/_definst_/rti3/chunklist.m3u8" took 8 milliseconds May 03 17:54:24 volumio volumio[6685]: info: ------------------------------ 4ms May 03 17:54:24 volumio volumio[6685]: info: ------------------------------ 3ms May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::parseTrackInfo May 03 17:54:24 volumio volumio[6685]: info: CoreStateMachine::setConsumeUpdateService mpd May 03 17:54:24 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand play May 03 17:54:24 volumio volumio[6685]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 03 17:54:24 volumio volumio[6685]: info: ------------------------------ 24ms May 03 17:54:24 volumio volumio[6685]: info: May 03 17:54:24 volumio volumio[6685]: ---------------------------- MPD announces system playlist update May 03 17:54:24 volumio volumio[6685]: info: Ignoring MPD Status Update May 03 17:54:24 volumio volumio[6685]: info: May 03 17:54:24 volumio volumio[6685]: ---------------------------- MPD announces system playlist update May 03 17:54:24 volumio volumio[6685]: info: Ignoring MPD Status Update May 03 17:54:24 volumio volumio[6685]: info: ------------------------------ 6ms May 03 17:54:24 volumio volumio[6685]: info: sendMpdCommand play took 4 milliseconds May 03 17:54:24 volumio volumio[6685]: info: ------------------------------ 4ms May 03 17:54:24 volumio volumio[6685]: info: ------------------------------ 4ms May 03 17:54:27 volumio volumio[6685]: info: May 03 17:54:27 volumio volumio[6685]: ---------------------------- MPD announces state update: player May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::getState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand status May 03 17:54:27 volumio volumio[6685]: info: May 03 17:54:27 volumio volumio[6685]: ---------------------------- MPD announces state update: player May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::getState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand status May 03 17:54:27 volumio volumio[6685]: info: May 03 17:54:27 volumio volumio[6685]: ---------------------------- MPD announces state update: player May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::getState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand status May 03 17:54:27 volumio volumio[6685]: info: May 03 17:54:27 volumio volumio[6685]: ---------------------------- MPD announces state update: player May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::getState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand status May 03 17:54:27 volumio volumio[6685]: info: May 03 17:54:27 volumio volumio[6685]: ---------------------------- MPD announces state update: player May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::getState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand status May 03 17:54:27 volumio volumio[6685]: info: May 03 17:54:27 volumio volumio[6685]: ---------------------------- MPD announces state update: player May 03 17:54:27 volumio volumio[6685]: info: sendMpdCommand status took 8 milliseconds May 03 17:54:27 volumio volumio[6685]: info: sendMpdCommand status took 7 milliseconds May 03 17:54:27 volumio volumio[6685]: info: sendMpdCommand status took 6 milliseconds May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::getState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand status May 03 17:54:27 volumio volumio[6685]: info: sendMpdCommand status took 4 milliseconds May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::parseState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::parseState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::parseState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::parseState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 17:54:27 volumio volumio[6685]: info: sendMpdCommand status took 9 milliseconds May 03 17:54:27 volumio volumio[6685]: info: sendMpdCommand status took 6 milliseconds May 03 17:54:27 volumio volumio[6685]: info: sendMpdCommand playlistinfo took 5 milliseconds May 03 17:54:27 volumio volumio[6685]: info: sendMpdCommand playlistinfo took 6 milliseconds May 03 17:54:27 volumio volumio[6685]: info: sendMpdCommand playlistinfo took 6 milliseconds May 03 17:54:27 volumio volumio[6685]: info: sendMpdCommand playlistinfo took 3 milliseconds May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::parseState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::parseState May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::parseTrackInfo May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::parseTrackInfo May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::pushState May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::servicePushState May 03 17:54:27 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:27 volumio volumio[6685]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":32,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://streamak0138.akamaized.net/live0138lh-mbm9/_definst_/rti3/chunklist.m3u8","trackType":"m3u8"} May 03 17:54:27 volumio volumio[6685]: verbose: CURRENT POSITION 0 May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState stateService play May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState currentStatus stop May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::pushState May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::servicePushState May 03 17:54:27 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:27 volumio volumio[6685]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15,"duration":0,"samplerate":32,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://streamak0138.akamaized.net/live0138lh-mbm9/_definst_/rti3/chunklist.m3u8","trackType":"m3u8"} May 03 17:54:27 volumio volumio[6685]: verbose: CURRENT POSITION 0 May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState stateService play May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState currentStatus play May 03 17:54:27 volumio volumio[6685]: info: Received an update from plugin. extracting info from payload May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:54:27 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::pushState May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::servicePushState May 03 17:54:27 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:27 volumio volumio[6685]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31,"duration":0,"samplerate":32,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://streamak0138.akamaized.net/live0138lh-mbm9/_definst_/rti3/chunklist.m3u8","trackType":"m3u8"} May 03 17:54:27 volumio volumio[6685]: verbose: CURRENT POSITION 0 May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState stateService play May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState currentStatus play May 03 17:54:27 volumio volumio[6685]: info: Received an update from plugin. extracting info from payload May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:54:27 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::pushState May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::servicePushState May 03 17:54:27 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:27 volumio volumio[6685]: verbose: STATE SERVICE {"status":"play","position":0,"seek":376,"duration":0,"samplerate":32,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://streamak0138.akamaized.net/live0138lh-mbm9/_definst_/rti3/chunklist.m3u8","trackType":"m3u8"} May 03 17:54:27 volumio volumio[6685]: verbose: CURRENT POSITION 0 May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState stateService play May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState currentStatus play May 03 17:54:27 volumio volumio[6685]: info: Received an update from plugin. extracting info from payload May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:54:27 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:54:27 volumio volumio[6685]: info: ------------------------------ 61ms May 03 17:54:27 volumio volumio[6685]: info: ------------------------------ 82ms May 03 17:54:27 volumio volumio[6685]: info: ------------------------------ 82ms May 03 17:54:27 volumio volumio[6685]: info: ------------------------------ 79ms May 03 17:54:27 volumio volumio[6685]: info: sendMpdCommand playlistinfo took 69 milliseconds May 03 17:54:27 volumio volumio[6685]: verbose: ControllerMpd::parseTrackInfo May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::pushState May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::servicePushState May 03 17:54:27 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:27 volumio volumio[6685]: verbose: STATE SERVICE {"status":"play","position":0,"seek":455,"duration":0,"samplerate":32,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://streamak0138.akamaized.net/live0138lh-mbm9/_definst_/rti3/chunklist.m3u8","trackType":"m3u8"} May 03 17:54:27 volumio volumio[6685]: verbose: CURRENT POSITION 0 May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState stateService play May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState currentStatus play May 03 17:54:27 volumio volumio[6685]: info: Received an update from plugin. extracting info from payload May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:54:27 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:54:27 volumio volumio[6685]: info: ControllerMpd::pushState May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::servicePushState May 03 17:54:27 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:27 volumio volumio[6685]: verbose: STATE SERVICE {"status":"play","position":0,"seek":972,"duration":0,"samplerate":32,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://streamak0138.akamaized.net/live0138lh-mbm9/_definst_/rti3/chunklist.m3u8","trackType":"m3u8"} May 03 17:54:27 volumio volumio[6685]: verbose: CURRENT POSITION 0 May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState stateService play May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::syncState currentStatus play May 03 17:54:27 volumio volumio[6685]: info: Received an update from plugin. extracting info from payload May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:54:27 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:54:27 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:54:27 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:54:27 volumio volumio[6685]: info: ------------------------------ 159ms May 03 17:54:27 volumio volumio[6685]: info: ------------------------------ 159ms May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 03 17:54:37 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 03 17:55:18 volumio volumio[6685]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object] May 03 17:55:18 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts May 03 17:55:18 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions May 03 17:55:18 volumio sudo[7688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 03 17:55:18 volumio sudo[7688]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 17:55:18 volumio sudo[7688]: pam_unix(sudo:session): session closed for user root May 03 17:55:18 volumio volumio[6685]: info: MPD Permissions set May 03 17:55:18 volumio sudo[7690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 03 17:55:18 volumio sudo[7690]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 17:55:18 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 17:55:18 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 17:55:18 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 17:55:18 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 17:55:18 volumio systemd[1]: Stopping Music Player Daemon... May 03 17:55:18 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 03 17:55:18 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 03 17:55:18 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 17:55:22 volumio systemd[1]: mpd.service: Succeeded. May 03 17:55:22 volumio systemd[1]: Stopped Music Player Daemon. May 03 17:55:22 volumio systemd[1]: Starting Music Player Daemon... May 03 17:55:22 volumio sudo[7702]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 03 17:55:22 volumio sudo[7702]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 17:55:22 volumio sudo[7702]: pam_unix(sudo:session): session closed for user root May 03 17:55:23 volumio mpd[7705]: May 03 17:55 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 03 17:55:23 volumio systemd[1]: Started Music Player Daemon. May 03 17:55:23 volumio sudo[7690]: pam_unix(sudo:session): session closed for user root May 03 17:55:23 volumio volumio[6685]: error: updateQueue error: null May 03 17:55:48 volumio volumio[6685]: info: CoreCommandRouter::volumioGetState May 03 17:55:49 volumio volumio[6685]: info: CoreCommandRouter::volumioStop May 03 17:55:49 volumio volumio[6685]: info: CoreStateMachine::stop May 03 17:55:49 volumio volumio[6685]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 17:55:49 volumio volumio[6685]: info: CoreStateMachine::stPlaybackTimer May 03 17:55:49 volumio volumio[6685]: info: CoreStateMachine::updateTrackBlock May 03 17:55:49 volumio volumio[6685]: info: CorePlayQueue::getTrackBlock May 03 17:55:49 volumio volumio[6685]: info: CoreStateMachine::pushState May 03 17:55:49 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:55:49 volumio volumio[6685]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 17:55:49 volumio volumio[6685]: info: CoreCommandRouter::volumioPushState May 03 17:55:49 volumio volumio[6685]: info: CoreStateMachine::serviceStop May 03 17:55:49 volumio volumio[6685]: info: CorePlayQueue::getTrack 0 May 03 17:55:49 volumio volumio[6685]: info: CoreCommandRouter::serviceStop May 03 17:55:49 volumio volumio[6685]: info: [1746266149939] ControllerWebradio::stop May 03 17:55:49 volumio volumio[6685]: verbose: ControllerMpd::sendMpdCommand stop May 03 17:55:49 volumio volumio[6685]: info: sendMpdCommand stop took 6 milliseconds May 03 17:55:50 volumio volumio[6685]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 17:55:50 volumio volumio[6685]: Error: connect ETIMEDOUT 104.244.46.93:80 May 03 17:55:50 volumio volumio[6685]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 03 17:55:50 volumio volumio[6685]: errno: -110, May 03 17:55:50 volumio volumio[6685]: code: 'ETIMEDOUT', May 03 17:55:50 volumio volumio[6685]: syscall: 'connect', May 03 17:55:50 volumio volumio[6685]: address: '104.244.46.93', May 03 17:55:50 volumio volumio[6685]: port: 80 May 03 17:55:50 volumio volumio[6685]: } May 03 17:55:50 volumio volumio[6685]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 17:55:51 volumio sudo[7766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-03 17:54 May 03 17:55:51 volumio sudo[7766]: 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="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"