Oct 02 21:54:00 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:54:00 volumio volumio[1255]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::ClearQueue Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:00 volumio volumio[1255]: info: CorePlayQueue::clearPlayQueue Oct 02 21:54:00 volumio volumio[1255]: info: CorePlayQueue::saveQueue Oct 02 21:54:00 volumio volumio[1255]: info: CoreCommandRouter::volumioPushQueue Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::addQueueItems Oct 02 21:54:00 volumio volumio[1255]: info: CorePlayQueue::addQueueItems Oct 02 21:54:00 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:54:00 volumio volumio[1255]: info: Adding Item to queue: rbrowser/station/961d03f2-0601-11e8-ae97-52543be04c81 Oct 02 21:54:00 volumio volumio[1255]: info: Exploding uri rbrowser/station/961d03f2-0601-11e8-ae97-52543be04c81 in service radio_browser Oct 02 21:54:00 volumio volumio[1255]: info: CoreCommandRouter::volumioPushQueue Oct 02 21:54:00 volumio volumio[1255]: info: CorePlayQueue::saveQueue Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::updateTrackBlock Oct 02 21:54:00 volumio volumio[1255]: info: CorePlayQueue::getTrackBlock Oct 02 21:54:00 volumio volumio[1255]: info: CoreCommandRouter::volumioGetState Oct 02 21:54:00 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:00 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 02 21:54:00 volumio volumio[1255]: info: CoreCommandRouter::volumioPlay Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::play index 0 Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::play index undefined Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:00 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:00 volumio volumio[1255]: info: CoreStateMachine::startPlaybackTimer Oct 02 21:54:00 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:00 volumio volumio[1255]: info: CoreCommandRouter::volumioGetVisibleSources Oct 02 21:54:00 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 21:54:00 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 02 21:54:00 volumio volumio[1255]: verbose: ControllerMpd::clearAddPlayTracks http://23613.live.streamtheworld.com/RIJEKAAAC_SC Oct 02 21:54:00 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 21:54:00 volumio volumio[1255]: info: Oct 02 21:54:00 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:00 volumio volumio[1255]: info: sendMpdCommand stop took 10 milliseconds Oct 02 21:54:00 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:00 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:00 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand clear Oct 02 21:54:00 volumio volumio[1255]: info: Oct 02 21:54:00 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:54:00 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:54:00 volumio volumio[1255]: info: sendMpdCommand status took 1 milliseconds Oct 02 21:54:00 volumio volumio[1255]: info: sendMpdCommand clear took 1 milliseconds Oct 02 21:54:00 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:00 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:00 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand add "http://23613.live.streamtheworld.com/RIJEKAAAC_SC" Oct 02 21:54:00 volumio volumio[1255]: error: updateQueue error: null Oct 02 21:54:00 volumio volumio[1255]: info: ------------------------------ 1ms Oct 02 21:54:00 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 02 21:54:00 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:00 volumio volumio[1255]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Oct 02 21:54:00 volumio volumio[1255]: info: ------------------------------ 3ms Oct 02 21:54:00 volumio volumio[1255]: info: Oct 02 21:54:00 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:54:00 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:54:00 volumio volumio[1255]: info: sendMpdCommand add "http://23613.live.streamtheworld.com/RIJEKAAAC_SC" took 2 milliseconds Oct 02 21:54:00 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand play Oct 02 21:54:00 volumio volumio[1255]: info: ------------------------------ 2ms Oct 02 21:54:00 volumio volumio[1255]: info: sendMpdCommand play took 1 milliseconds Oct 02 21:54:01 volumio volumio[1255]: info: Oct 02 21:54:01 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:01 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:01 volumio volumio[1255]: info: Oct 02 21:54:01 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:01 volumio volumio[1255]: info: sendMpdCommand status took 2 milliseconds Oct 02 21:54:01 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:01 volumio volumio[1255]: info: sendMpdCommand status took 1 milliseconds Oct 02 21:54:01 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:01 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:01 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:01 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:01 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"RIJEKAAAC_SC","artist":null,"album":null,"uri":"http://23613.live.streamtheworld.com/RIJEKAAAC_SC","trackType":""} Oct 02 21:54:01 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:01 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:54:01 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Oct 02 21:54:01 volumio volumio[1255]: info: ------------------------------ 5ms Oct 02 21:54:01 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:01 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:01 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:01 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:01 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"RIJEKAAAC_SC","artist":null,"album":null,"uri":"http://23613.live.streamtheworld.com/RIJEKAAAC_SC","trackType":""} Oct 02 21:54:01 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:01 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:54:01 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus play Oct 02 21:54:01 volumio volumio[1255]: info: Received an update from plugin. extracting info from payload Oct 02 21:54:01 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:01 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:01 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:54:01 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:01 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:01 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:01 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:01 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:01.764+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 21:54:01 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:01.765+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://23613.live.streamtheworld.com/RIJEKAAAC_SC title="HRT Radio Rijeka" Oct 02 21:54:01 volumio volumio[1255]: info: ------------------------------ 16ms Oct 02 21:54:01 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:01.770+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 21:54:01 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:01.770+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://23613.live.streamtheworld.com/RIJEKAAAC_SC title="HRT Radio Rijeka" Oct 02 21:54:01 volumio volumio[1255]: info: Oct 02 21:54:01 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:54:01 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:54:01 volumio volumio[1255]: info: Oct 02 21:54:01 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:01 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:01 volumio volumio[1255]: info: ------------------------------ 3ms Oct 02 21:54:01 volumio volumio[1255]: info: sendMpdCommand status took 3 milliseconds Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:01 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 02 21:54:01 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:01 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:01 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:01 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:01 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"65 Kbps","isStreaming":false,"title":"TAVARES - HEAVEN MUST BE MISSING AN ANGEL","artist":"RIJEKA","album":null,"uri":"http://23613.live.streamtheworld.com/RIJEKAAAC_SC","trackType":""} Oct 02 21:54:01 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:01 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:54:01 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus play Oct 02 21:54:01 volumio volumio[1255]: info: Received an update from plugin. extracting info from payload Oct 02 21:54:01 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:01 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:01 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:54:01 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:01 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:01 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:01 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:01 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:01.802+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=881 volume=100 Oct 02 21:54:01 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:01.802+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://23613.live.streamtheworld.com/RIJEKAAAC_SC title="HRT Radio Rijeka" Oct 02 21:54:01 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:01.803+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=881 volume=100 Oct 02 21:54:01 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:01.803+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://23613.live.streamtheworld.com/RIJEKAAAC_SC title="HRT Radio Rijeka" Oct 02 21:54:01 volumio volumio[1255]: info: ------------------------------ 26ms Oct 02 21:54:02 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:02 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:03 volumio volumio[1255]: info: Executing endpoint metavolumio Oct 02 21:54:03 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 21:54:07 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:07 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:12 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:12 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:17 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:17 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:20 volumio volumio[1255]: Searching plugin music_service/radio_browser Oct 02 21:54:20 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: radio_browser , search Oct 02 21:54:20 volumio volumio[1255]: info: All search sources collected, pushing search results Oct 02 21:54:21 volumio volumio[1255]: Searching plugin music_service/radio_browser Oct 02 21:54:21 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: radio_browser , search Oct 02 21:54:21 volumio volumio[1255]: info: All search sources collected, pushing search results Oct 02 21:54:22 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:22 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:27 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:27 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:27 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:54:27 volumio volumio[1255]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::ClearQueue Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::stPlaybackTimer Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::updateTrackBlock Oct 02 21:54:27 volumio volumio[1255]: info: CorePlayQueue::getTrackBlock Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:27 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:27 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:54:27 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::serviceStop Oct 02 21:54:27 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:27 volumio volumio[1255]: info: CoreCommandRouter::serviceStop Oct 02 21:54:27 volumio volumio[1255]: info: ControllerMpd::stop Oct 02 21:54:27 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 21:54:27 volumio volumio[1255]: info: CorePlayQueue::clearPlayQueue Oct 02 21:54:27 volumio volumio[1255]: info: CorePlayQueue::saveQueue Oct 02 21:54:27 volumio volumio[1255]: info: CoreCommandRouter::volumioPushQueue Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::addQueueItems Oct 02 21:54:27 volumio volumio[1255]: info: CorePlayQueue::addQueueItems Oct 02 21:54:27 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:54:27 volumio volumio[1255]: info: Adding Item to queue: rbrowser/station/961e9c8c-0601-11e8-ae97-52543be04c81 Oct 02 21:54:27 volumio volumio[1255]: info: Exploding uri rbrowser/station/961e9c8c-0601-11e8-ae97-52543be04c81 in service radio_browser Oct 02 21:54:27 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:27.719+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 21:54:27 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:27.721+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://23613.live.streamtheworld.com/RIJEKAAAC_SC title="HRT Radio Rijeka" Oct 02 21:54:27 volumio volumio[1255]: info: Oct 02 21:54:27 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:27 volumio volumio[1255]: info: sendMpdCommand stop took 49 milliseconds Oct 02 21:54:27 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:27 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:27 volumio volumio[1255]: info: sendMpdCommand status took 4 milliseconds Oct 02 21:54:27 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:27 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:27 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 02 21:54:27 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:27 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:27 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:27 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:27 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:54:27 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:27 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:27 volumio volumio[1255]: 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":"TAVARES - HEAVEN MUST BE MISSING AN ANGEL","artist":"RIJEKA","album":null,"uri":"http://23613.live.streamtheworld.com/RIJEKAAAC_SC","trackType":""} Oct 02 21:54:27 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::syncState stateService stop Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:27 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:27 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:27 volumio volumio[1255]: info: No code Oct 02 21:54:27 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:27 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:27 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:27 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:27.783+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 21:54:27 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:27.783+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id= title= Oct 02 21:54:27 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:27.784+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 21:54:27 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:27.784+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id= title= Oct 02 21:54:27 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:27.785+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 21:54:27 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:27.785+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id= title= Oct 02 21:54:27 volumio volumio[1255]: info: ------------------------------ 33ms Oct 02 21:54:27 volumio volumio[1255]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 02 21:54:28 volumio volumio[1255]: info: CoreCommandRouter::volumioPushQueue Oct 02 21:54:28 volumio volumio[1255]: info: CorePlayQueue::saveQueue Oct 02 21:54:28 volumio volumio[1255]: info: CoreStateMachine::updateTrackBlock Oct 02 21:54:28 volumio volumio[1255]: info: CorePlayQueue::getTrackBlock Oct 02 21:54:28 volumio volumio[1255]: info: CoreCommandRouter::volumioGetState Oct 02 21:54:28 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:28 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 02 21:54:28 volumio volumio[1255]: info: CoreCommandRouter::volumioPlay Oct 02 21:54:28 volumio volumio[1255]: info: CoreStateMachine::play index 0 Oct 02 21:54:28 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:28 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:54:28 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:28 volumio volumio[1255]: info: CoreStateMachine::play index undefined Oct 02 21:54:28 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:28 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:28 volumio volumio[1255]: info: CoreStateMachine::startPlaybackTimer Oct 02 21:54:28 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:28 volumio volumio[1255]: info: CoreCommandRouter::volumioGetVisibleSources Oct 02 21:54:28 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 21:54:28 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 02 21:54:28 volumio volumio[1255]: verbose: ControllerMpd::clearAddPlayTracks http://25603.live.streamtheworld.com/SLJEMEAAC_SC Oct 02 21:54:28 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 21:54:28 volumio volumio[1255]: info: sendMpdCommand stop took 2 milliseconds Oct 02 21:54:28 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand clear Oct 02 21:54:28 volumio volumio[1255]: info: Oct 02 21:54:28 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:54:28 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:54:28 volumio volumio[1255]: info: sendMpdCommand clear took 1 milliseconds Oct 02 21:54:28 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand add "http://25603.live.streamtheworld.com/SLJEMEAAC_SC" Oct 02 21:54:28 volumio volumio[1255]: error: updateQueue error: null Oct 02 21:54:28 volumio volumio[1255]: info: Oct 02 21:54:28 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:54:28 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:54:28 volumio volumio[1255]: info: ------------------------------ 2ms Oct 02 21:54:28 volumio volumio[1255]: info: sendMpdCommand add "http://25603.live.streamtheworld.com/SLJEMEAAC_SC" took 1 milliseconds Oct 02 21:54:28 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand play Oct 02 21:54:28 volumio volumio[1255]: info: ------------------------------ 2ms Oct 02 21:54:28 volumio volumio[1255]: info: sendMpdCommand play took 1 milliseconds Oct 02 21:54:29 volumio volumio[1255]: info: Oct 02 21:54:29 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:29 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:29 volumio volumio[1255]: info: Oct 02 21:54:29 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:29 volumio volumio[1255]: info: sendMpdCommand status took 2 milliseconds Oct 02 21:54:29 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:29 volumio volumio[1255]: info: sendMpdCommand status took 2 milliseconds Oct 02 21:54:29 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:29 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:29 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:29 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:29 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"SLJEMEAAC_SC","artist":null,"album":null,"uri":"http://25603.live.streamtheworld.com/SLJEMEAAC_SC","trackType":""} Oct 02 21:54:29 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:29 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:54:29 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Oct 02 21:54:29 volumio volumio[1255]: info: ------------------------------ 5ms Oct 02 21:54:29 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:29 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:29 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:29 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:29 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"SLJEMEAAC_SC","artist":null,"album":null,"uri":"http://25603.live.streamtheworld.com/SLJEMEAAC_SC","trackType":""} Oct 02 21:54:29 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:29 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:54:29 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus play Oct 02 21:54:29 volumio volumio[1255]: info: Received an update from plugin. extracting info from payload Oct 02 21:54:29 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:29 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:29 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:54:29 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:29 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:29 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:29 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:29 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:29.137+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 21:54:29 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:29.137+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://25603.live.streamtheworld.com/SLJEMEAAC_SC title="HRT Radio Sljeme" Oct 02 21:54:29 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:29.137+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 21:54:29 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:29.138+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://25603.live.streamtheworld.com/SLJEMEAAC_SC title="HRT Radio Sljeme" Oct 02 21:54:29 volumio volumio[1255]: info: ------------------------------ 17ms Oct 02 21:54:29 volumio volumio[1255]: info: Oct 02 21:54:29 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:54:29 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:54:29 volumio volumio[1255]: info: Oct 02 21:54:29 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:29 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:29 volumio volumio[1255]: info: ------------------------------ 28ms Oct 02 21:54:29 volumio volumio[1255]: info: sendMpdCommand status took 28 milliseconds Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:29 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 02 21:54:29 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:29 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:29 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:29 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:29 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"65 Kbps","isStreaming":false,"title":"VIŠNJA KORBAR - PRI VESELOJ ZAGORKI","artist":"SLJEME","album":null,"uri":"http://25603.live.streamtheworld.com/SLJEMEAAC_SC","trackType":""} Oct 02 21:54:29 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:29 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:54:29 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus play Oct 02 21:54:29 volumio volumio[1255]: info: Received an update from plugin. extracting info from payload Oct 02 21:54:29 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:29 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:29 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:54:29 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:29 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:29 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:29 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:29 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:29.196+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=881 volume=100 Oct 02 21:54:29 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:29.196+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://25603.live.streamtheworld.com/SLJEMEAAC_SC title="HRT Radio Sljeme" Oct 02 21:54:29 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:29.196+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=881 volume=100 Oct 02 21:54:29 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:29.197+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://25603.live.streamtheworld.com/SLJEMEAAC_SC title="HRT Radio Sljeme" Oct 02 21:54:29 volumio volumio[1255]: info: ------------------------------ 62ms Oct 02 21:54:31 volumio volumio[1255]: info: Executing endpoint metavolumio Oct 02 21:54:31 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 21:54:32 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:32 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:37 volumio volumio[1255]: info: CoreCommandRouter::volumioPause Oct 02 21:54:37 volumio volumio[1255]: info: CoreStateMachine::pause Oct 02 21:54:37 volumio volumio[1255]: info: CoreStateMachine::stPlaybackTimer Oct 02 21:54:37 volumio volumio[1255]: info: CoreStateMachine::servicePause Oct 02 21:54:37 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:37 volumio volumio[1255]: info: CoreCommandRouter::servicePause Oct 02 21:54:37 volumio volumio[1255]: info: ControllerMpd::pause Oct 02 21:54:37 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand pause Oct 02 21:54:37 volumio volumio[1255]: info: Oct 02 21:54:37 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:37 volumio volumio[1255]: info: sendMpdCommand pause took 3 milliseconds Oct 02 21:54:37 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:37 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:37 volumio volumio[1255]: info: sendMpdCommand status took 1 milliseconds Oct 02 21:54:37 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:37 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:37 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 02 21:54:37 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:37 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:37 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:37 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:37 volumio volumio[1255]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":8886,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"65 Kbps","isStreaming":false,"title":"VIŠNJA KORBAR - PRI VESELOJ ZAGORKI","artist":"SLJEME","album":null,"uri":"http://25603.live.streamtheworld.com/SLJEMEAAC_SC","trackType":""} Oct 02 21:54:37 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:37 volumio volumio[1255]: info: CoreStateMachine::syncState stateService pause Oct 02 21:54:37 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus pause Oct 02 21:54:37 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:37 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:37 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:54:37 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:37 volumio volumio[1255]: info: CoreStateMachine::stPlaybackTimer Oct 02 21:54:37 volumio volumio[1255]: info: ------------------------------ 11ms Oct 02 21:54:37 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:37.181+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PAUSED positionMs=8885 volume=100 Oct 02 21:54:37 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:37.181+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://25603.live.streamtheworld.com/SLJEMEAAC_SC title="HRT Radio Sljeme" Oct 02 21:54:37 volumio volumio[1255]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 02 21:54:37 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:37 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:39 volumio volumio[1255]: info: Executing endpoint metavolumio Oct 02 21:54:39 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 21:54:42 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:42 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:45 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 02 21:54:45 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:54:47 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:47 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:49 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 02 21:54:49 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:54:51 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 02 21:54:51 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:54:52 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:52 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:54 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::ClearQueue Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::updateTrackBlock Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::getTrackBlock Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::stPlaybackTimer Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::serviceStop Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::serviceStop Oct 02 21:54:54 volumio volumio[1255]: info: ControllerMpd::stop Oct 02 21:54:54 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::clearPlayQueue Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::saveQueue Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::volumioPushQueue Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::addQueueItems Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::addQueueItems Oct 02 21:54:54 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:54:54 volumio volumio[1255]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s342094 Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 02 21:54:54 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:54.325+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 21:54:54 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:54.326+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://25603.live.streamtheworld.com/SLJEMEAAC_SC title="HRT Radio Sljeme" Oct 02 21:54:54 volumio volumio[1255]: info: Oct 02 21:54:54 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:54 volumio volumio[1255]: info: sendMpdCommand stop took 52 milliseconds Oct 02 21:54:54 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:54 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:54 volumio volumio[1255]: info: sendMpdCommand status took 2 milliseconds Oct 02 21:54:54 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:54 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:54 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 14 milliseconds Oct 02 21:54:54 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:54 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:54 volumio volumio[1255]: 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":"VIŠNJA KORBAR - PRI VESELOJ ZAGORKI","artist":"SLJEME","album":null,"uri":"http://25603.live.streamtheworld.com/SLJEMEAAC_SC","trackType":""} Oct 02 21:54:54 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::syncState stateService stop Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:54 volumio volumio[1255]: info: No code Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:54 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:54.397+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 21:54:54 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:54.397+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id= title= Oct 02 21:54:54 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:54.397+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 21:54:54 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:54.397+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id= title= Oct 02 21:54:54 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:54.398+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 21:54:54 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:54.398+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id= title= Oct 02 21:54:54 volumio volumio[1255]: info: ------------------------------ 37ms Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::volumioPushQueue Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::saveQueue Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::updateTrackBlock Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::getTrackBlock Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::volumioGetState Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::volumioPlay Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::play index 0 Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::play index undefined Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:54 volumio volumio[1255]: info: CoreStateMachine::startPlaybackTimer Oct 02 21:54:54 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::volumioGetVisibleSources Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 21:54:54 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 02 21:54:54 volumio volumio[1255]: info: [1790970894759] ControllerWebradio::clearAddPlayTrack Oct 02 21:54:54 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 21:54:54 volumio volumio[1255]: info: sendMpdCommand stop took 5 milliseconds Oct 02 21:54:54 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand clear Oct 02 21:54:54 volumio volumio[1255]: info: Oct 02 21:54:54 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:54:54 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:54:54 volumio volumio[1255]: info: sendMpdCommand clear took 1 milliseconds Oct 02 21:54:54 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand load "https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3" Oct 02 21:54:54 volumio volumio[1255]: error: updateQueue error: null Oct 02 21:54:54 volumio volumio[1255]: info: ------------------------------ 2ms Oct 02 21:54:55 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand add "https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3" Oct 02 21:54:55 volumio volumio[1255]: info: sendMpdCommand add "https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3" took 1 milliseconds Oct 02 21:54:55 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 02 21:54:55 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand play Oct 02 21:54:55 volumio volumio[1255]: info: Oct 02 21:54:55 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:54:55 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:54:55 volumio volumio[1255]: info: sendMpdCommand play took 2 milliseconds Oct 02 21:54:55 volumio volumio[1255]: info: ------------------------------ 2ms Oct 02 21:54:56 volumio volumio[1255]: info: Oct 02 21:54:56 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:56 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:56 volumio volumio[1255]: info: Oct 02 21:54:56 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:56 volumio volumio[1255]: info: sendMpdCommand status took 2 milliseconds Oct 02 21:54:56 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:56 volumio volumio[1255]: info: sendMpdCommand status took 1 milliseconds Oct 02 21:54:56 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:56 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:56 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:56 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:56 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"live.mp3","artist":null,"album":null,"uri":"https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3","trackType":"mp3"} Oct 02 21:54:56 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:56 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:54:56 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Oct 02 21:54:56 volumio volumio[1255]: info: ------------------------------ 5ms Oct 02 21:54:56 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:56 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:56 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:56 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:56 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"live.mp3","artist":null,"album":null,"uri":"https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3","trackType":"mp3"} Oct 02 21:54:56 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:56 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:54:56 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus play Oct 02 21:54:56 volumio volumio[1255]: info: Received an update from plugin. extracting info from payload Oct 02 21:54:56 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:56 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:56 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:54:56 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:56 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:56 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:56 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:56.213+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 21:54:56 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:56.213+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3 title="Radio Rojc Pula" Oct 02 21:54:56 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:56.213+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 21:54:56 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:56.213+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3 title="Radio Rojc Pula" Oct 02 21:54:56 volumio volumio[1255]: info: ------------------------------ 15ms Oct 02 21:54:56 volumio volumio[1255]: info: Oct 02 21:54:56 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:54:56 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:54:56 volumio volumio[1255]: info: Oct 02 21:54:56 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:54:56 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:54:56 volumio volumio[1255]: info: ------------------------------ 14ms Oct 02 21:54:56 volumio volumio[1255]: info: sendMpdCommand status took 14 milliseconds Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:54:56 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 02 21:54:56 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:54:56 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:54:56 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:54:56 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:56 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","position":0,"seek":968,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"live.mp3","artist":"live.mp3","album":null,"uri":"https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3","trackType":"mp3"} Oct 02 21:54:56 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:54:56 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:54:56 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus play Oct 02 21:54:56 volumio volumio[1255]: info: Received an update from plugin. extracting info from payload Oct 02 21:54:56 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:56 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:54:56 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:54:56 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:56 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:54:56 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:54:56 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:56.237+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 21:54:56 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:56.237+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3 title="Radio Rojc Pula" Oct 02 21:54:56 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:56.238+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 21:54:56 volumio volumio5-onboarding[1637]: time=2026-10-02T21:54:56.238+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3 title="Radio Rojc Pula" Oct 02 21:54:56 volumio volumio[1255]: info: ------------------------------ 27ms Oct 02 21:54:57 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:57 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:54:58 volumio volumio[1255]: info: Executing endpoint metavolumio Oct 02 21:54:58 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 21:54:58 volumio volumio[1255]: info: Executing endpoint metavolumio Oct 02 21:54:58 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 21:55:02 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:02 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:03 volumio volumio[1255]: info: CoreCommandRouter::volumioStop Oct 02 21:55:03 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:55:03 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:55:03 volumio volumio[1255]: info: CoreStateMachine::stPlaybackTimer Oct 02 21:55:03 volumio volumio[1255]: info: CoreStateMachine::updateTrackBlock Oct 02 21:55:03 volumio volumio[1255]: info: CorePlayQueue::getTrackBlock Oct 02 21:55:03 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:55:03 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:03 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:55:03 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:55:03 volumio volumio[1255]: info: CoreStateMachine::serviceStop Oct 02 21:55:03 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:03 volumio volumio[1255]: info: CoreCommandRouter::serviceStop Oct 02 21:55:03 volumio volumio[1255]: info: [1790970903534] ControllerWebradio::stop Oct 02 21:55:03 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 21:55:03 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:03.539+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 21:55:03 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:03.539+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3 title="Radio Rojc Pula" Oct 02 21:55:03 volumio volumio[1255]: info: Oct 02 21:55:03 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:55:03 volumio volumio[1255]: info: sendMpdCommand stop took 27 milliseconds Oct 02 21:55:03 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:55:03 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:55:03 volumio volumio[1255]: info: sendMpdCommand status took 2 milliseconds Oct 02 21:55:03 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:55:03 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:55:03 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 02 21:55:03 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:55:03 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:55:03 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:55:03 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:55:03 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:03 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:55:03 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:03 volumio volumio[1255]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 02 21:55:03 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:03.580+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 21:55:03 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:03.580+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=https://cf.widecastcdn.live/Z07ww1NUNl/live.mp3 title="Radio Rojc Pula" Oct 02 21:55:03 volumio volumio[1255]: info: ------------------------------ 21ms Oct 02 21:55:03 volumio volumio[1255]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 02 21:55:05 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:55:05 volumio volumio[1255]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::ClearQueue Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:55:05 volumio volumio[1255]: info: CorePlayQueue::clearPlayQueue Oct 02 21:55:05 volumio volumio[1255]: info: CorePlayQueue::saveQueue Oct 02 21:55:05 volumio volumio[1255]: info: CoreCommandRouter::volumioPushQueue Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::addQueueItems Oct 02 21:55:05 volumio volumio[1255]: info: CorePlayQueue::addQueueItems Oct 02 21:55:05 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:55:05 volumio volumio[1255]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8 Oct 02 21:55:05 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 02 21:55:05 volumio volumio[1255]: info: CoreCommandRouter::volumioPushQueue Oct 02 21:55:05 volumio volumio[1255]: info: CorePlayQueue::saveQueue Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::updateTrackBlock Oct 02 21:55:05 volumio volumio[1255]: info: CorePlayQueue::getTrackBlock Oct 02 21:55:05 volumio volumio[1255]: info: CoreCommandRouter::volumioGetState Oct 02 21:55:05 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:05 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 02 21:55:05 volumio volumio[1255]: info: CoreCommandRouter::volumioPlay Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::play index 0 Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::play index undefined Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:55:05 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::startPlaybackTimer Oct 02 21:55:05 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:05 volumio volumio[1255]: info: CoreCommandRouter::volumioGetVisibleSources Oct 02 21:55:05 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 21:55:05 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 02 21:55:05 volumio volumio[1255]: info: [1790970905396] ControllerWebradio::clearAddPlayTrack Oct 02 21:55:05 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 21:55:05 volumio volumio[1255]: info: sendMpdCommand stop took 2 milliseconds Oct 02 21:55:05 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand clear Oct 02 21:55:05 volumio volumio[1255]: info: Oct 02 21:55:05 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:55:05 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:55:05 volumio volumio[1255]: info: sendMpdCommand clear took 0 milliseconds Oct 02 21:55:05 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8" Oct 02 21:55:05 volumio volumio[1255]: error: updateQueue error: null Oct 02 21:55:05 volumio volumio[1255]: info: Oct 02 21:55:05 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:55:05 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:55:05 volumio volumio[1255]: info: ------------------------------ 2ms Oct 02 21:55:05 volumio volumio[1255]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8" took 1 milliseconds Oct 02 21:55:05 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 02 21:55:05 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand play Oct 02 21:55:05 volumio volumio[1255]: info: ------------------------------ 1ms Oct 02 21:55:05 volumio volumio[1255]: info: sendMpdCommand play took 1 milliseconds Oct 02 21:55:05 volumio volumio[1255]: info: Executing endpoint metavolumio Oct 02 21:55:05 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 21:55:06 volumio volumio[1255]: info: Oct 02 21:55:06 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:55:06 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:55:06 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:55:06 volumio volumio[1255]: info: Oct 02 21:55:06 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:55:06 volumio volumio[1255]: info: sendMpdCommand status took 2 milliseconds Oct 02 21:55:06 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:55:06 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:55:06 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:55:06 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:55:06 volumio volumio[1255]: info: sendMpdCommand status took 1 milliseconds Oct 02 21:55:06 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 02 21:55:06 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:55:06 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:55:06 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:55:06 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:55:06 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:55:06 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:06 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_6music-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Oct 02 21:55:06 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:55:06 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:55:06 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Oct 02 21:55:06 volumio volumio[1255]: info: ------------------------------ 5ms Oct 02 21:55:06 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 02 21:55:06 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:55:06 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:55:06 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:55:06 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:06 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_6music-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Oct 02 21:55:06 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:55:06 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:55:06 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus play Oct 02 21:55:06 volumio volumio[1255]: info: Received an update from plugin. extracting info from payload Oct 02 21:55:06 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:55:06 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:06 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:55:06 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:55:06 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:55:06 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:55:06 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:06.039+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 21:55:06 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:06.039+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8 title="BBC Radio 6 Music (128k)" Oct 02 21:55:06 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:06.040+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 21:55:06 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:06.040+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8 title="BBC Radio 6 Music (128k)" Oct 02 21:55:06 volumio volumio[1255]: info: ------------------------------ 18ms Oct 02 21:55:07 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:07 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:08 volumio volumio[1255]: info: Executing endpoint metavolumio Oct 02 21:55:08 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 21:55:08 volumio volumio[1255]: info: CoreCommandRouter::volumioStop Oct 02 21:55:08 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:55:08 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:55:08 volumio volumio[1255]: info: CoreStateMachine::stPlaybackTimer Oct 02 21:55:08 volumio volumio[1255]: info: CoreStateMachine::updateTrackBlock Oct 02 21:55:08 volumio volumio[1255]: info: CorePlayQueue::getTrackBlock Oct 02 21:55:08 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:55:08 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:08 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:55:08 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:55:08 volumio volumio[1255]: info: CoreStateMachine::serviceStop Oct 02 21:55:08 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:08 volumio volumio[1255]: info: CoreCommandRouter::serviceStop Oct 02 21:55:08 volumio volumio[1255]: info: [1790970908406] ControllerWebradio::stop Oct 02 21:55:08 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 21:55:08 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:08.407+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 21:55:08 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:08.407+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8 title="BBC Radio 6 Music (128k)" Oct 02 21:55:08 volumio volumio[1255]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 02 21:55:10 volumio volumio[1255]: info: Executing endpoint metavolumio Oct 02 21:55:10 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 21:55:12 volumio volumio[1255]: info: Oct 02 21:55:12 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:55:12 volumio volumio[1255]: info: sendMpdCommand stop took 4170 milliseconds Oct 02 21:55:12 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:55:12 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:55:12 volumio volumio[1255]: info: sendMpdCommand status took 1 milliseconds Oct 02 21:55:12 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:55:12 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:55:12 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 02 21:55:12 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:55:12 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:55:12 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:55:12 volumio volumio[1255]: info: CoreStateMachine::pushState Oct 02 21:55:12 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:12 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:55:12 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Oct 02 21:55:12 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:12 volumio volumio[1255]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 02 21:55:12 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:12.582+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" state=STATUS_STOPPED positionMs=251 volume=100 Oct 02 21:55:12 volumio volumio[1255]: info: ------------------------------ 7ms Oct 02 21:55:12 volumio volumio5-onboarding[1637]: time=2026-10-02T21:55:12.584+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.117:54494 @ 0x1ca8c30" id=http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8 title="BBC Radio 6 Music (128k)" Oct 02 21:55:12 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:12 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:17 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , handleBrowseUri Oct 02 21:55:17 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:55:17 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:17 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:20 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:55:20 volumio volumio[1255]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::ClearQueue Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:55:20 volumio volumio[1255]: info: CorePlayQueue::clearPlayQueue Oct 02 21:55:20 volumio volumio[1255]: info: CorePlayQueue::saveQueue Oct 02 21:55:20 volumio volumio[1255]: info: CoreCommandRouter::volumioPushQueue Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::addQueueItems Oct 02 21:55:20 volumio volumio[1255]: info: CorePlayQueue::addQueueItems Oct 02 21:55:20 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:55:20 volumio volumio[1255]: info: Adding Item to queue: webrp/1 Oct 02 21:55:20 volumio volumio[1255]: info: Exploding uri webrp/1 in service radio_paradise Oct 02 21:55:20 volumio volumio[1255]: info: CoreCommandRouter::volumioPushQueue Oct 02 21:55:20 volumio volumio[1255]: info: CorePlayQueue::saveQueue Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::updateTrackBlock Oct 02 21:55:20 volumio volumio[1255]: info: CorePlayQueue::getTrackBlock Oct 02 21:55:20 volumio volumio[1255]: info: CoreCommandRouter::volumioGetState Oct 02 21:55:20 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:20 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 02 21:55:20 volumio volumio[1255]: info: CoreCommandRouter::volumioPlay Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::play index 0 Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::stop Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::play index undefined Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 21:55:20 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:20 volumio volumio[1255]: info: CoreStateMachine::startPlaybackTimer Oct 02 21:55:20 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:20 volumio volumio[1255]: info: CoreCommandRouter::volumioGetVisibleSources Oct 02 21:55:20 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 21:55:20 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 02 21:55:20 volumio volumio[1255]: info: [RadioParadise] Matched station: Radio Paradise Mellow Mix (FLAC), chan=1 Oct 02 21:55:20 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 21:55:20 volumio volumio[1255]: info: sendMpdCommand stop took 2 milliseconds Oct 02 21:55:20 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand clear Oct 02 21:55:20 volumio volumio[1255]: info: Oct 02 21:55:20 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:55:20 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:55:20 volumio volumio[1255]: info: sendMpdCommand clear took 0 milliseconds Oct 02 21:55:20 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 02 21:55:20 volumio volumio[1255]: error: updateQueue error: null Oct 02 21:55:20 volumio volumio[1255]: info: ------------------------------ 2ms Oct 02 21:55:20 volumio volumio[1255]: info: sendMpdCommand consume 1 took 1 milliseconds Oct 02 21:55:20 volumio volumio[1255]: info: [1790970920354] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/mellow-flacm Oct 02 21:55:20 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/mellow-flacm" Oct 02 21:55:20 volumio volumio[1255]: info: Oct 02 21:55:20 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:55:20 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:55:20 volumio volumio[1255]: info: sendMpdCommand add "https://stream.radioparadise.com/mellow-flacm" took 0 milliseconds Oct 02 21:55:20 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand play Oct 02 21:55:20 volumio volumio[1255]: info: ------------------------------ 4ms Oct 02 21:55:20 volumio volumio[1255]: info: sendMpdCommand play took 2 milliseconds Oct 02 21:55:20 volumio volumio[1255]: info: [RadioParadise] Using metadata URL: https://api.radioparadise.com/api/now_playing?chan=1 Oct 02 21:55:20 volumio volumio[1255]: info: [1790970920360] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1 Oct 02 21:55:21 volumio volumio[1255]: info: Oct 02 21:55:21 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:55:21 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:55:21 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:55:21 volumio volumio[1255]: info: sendMpdCommand status took 1 milliseconds Oct 02 21:55:21 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:55:21 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:55:21 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 02 21:55:21 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:55:21 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:55:21 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:55:21 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:21 volumio volumio[1255]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 02 21:55:21 volumio volumio[1255]: info: ------------------------------ 2ms Oct 02 21:55:21 volumio volumio[1255]: info: [1790970921148] [RadioParadise] received new metadata: {"time":213,"artist":"k.d. lang","title":"Helpless","album":"Hymns of the 49th Parallel","year":"2004","cover":"https://img.radioparadise.com/covers/l/17301.jpg","cover_med":"https://img.radioparadise.com/covers/m/17301.jpg","cover_small":"https://img.radioparadise.com/covers/s/17301.jpg"} Oct 02 21:55:21 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:21 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:55:21 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:21 volumio volumio[1255]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/17301.jpg","uri":"https://stream.radioparadise.com/mellow-flacm","name":"Helpless","title":"Helpless","artist":"k.d. lang","album":"Hymns of the 49th Parallel","streaming":true,"disableUiControls":true,"duration":218,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 02 21:55:21 volumio volumio[1255]: verbose: CURRENT POSITION 0 Oct 02 21:55:21 volumio volumio[1255]: info: CoreStateMachine::syncState stateService play Oct 02 21:55:21 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Oct 02 21:55:21 volumio volumio[1255]: info: [1790970921150] [RadioParadise] setting new timer with duration of 218000 seconds. Oct 02 21:55:21 volumio volumio[1255]: info: Oct 02 21:55:21 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:55:21 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:55:21 volumio volumio[1255]: info: Oct 02 21:55:21 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:55:21 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:55:21 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:55:21 volumio volumio[1255]: info: ------------------------------ 6ms Oct 02 21:55:21 volumio volumio[1255]: info: sendMpdCommand status took 1 milliseconds Oct 02 21:55:21 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:55:21 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:55:21 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 02 21:55:21 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:55:21 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:55:21 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:55:21 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:21 volumio volumio[1255]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 02 21:55:21 volumio volumio[1255]: info: ------------------------------ 3ms Oct 02 21:55:21 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:21 volumio volumio[1255]: info: CorePlayQueue::getTrack 1 Oct 02 21:55:22 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:22 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:25 volumio volumio[1255]: info: Oct 02 21:55:25 volumio volumio[1255]: ---------------------------- MPD announces system playlist update Oct 02 21:55:25 volumio volumio[1255]: info: Ignoring MPD Status Update Oct 02 21:55:25 volumio volumio[1255]: info: Oct 02 21:55:25 volumio volumio[1255]: ---------------------------- MPD announces state update: player Oct 02 21:55:25 volumio volumio[1255]: info: ControllerMpd::getState Oct 02 21:55:25 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:55:25 volumio volumio[1255]: info: ------------------------------ 1ms Oct 02 21:55:25 volumio volumio[1255]: info: sendMpdCommand status took 1 milliseconds Oct 02 21:55:25 volumio volumio[1255]: verbose: ControllerMpd::parseState Oct 02 21:55:25 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:55:25 volumio volumio[1255]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 02 21:55:25 volumio volumio[1255]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:55:25 volumio volumio[1255]: info: ControllerMpd::pushState Oct 02 21:55:25 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Oct 02 21:55:25 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Oct 02 21:55:25 volumio volumio[1255]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 02 21:55:25 volumio volumio[1255]: info: ------------------------------ 3ms Oct 02 21:55:26 volumio volumio[1255]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 21:55:26 volumio volumio[1255]: info: CoreCommandRouter::Close All Modals sent Oct 02 21:55:27 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:27 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:32 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:32 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:36 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Oct 02 21:55:36 volumio volumio[1255]: info: Preload queue cleared Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/03 - Lightnin' Hopkins - Mean Old Frisco.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/02 - Lightnin' Hopkins - You Better Watch Yourself.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/01 - Lightnin' Hopkins - Automobile Blues.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/10 - Lightnin' Hopkins - Down There Baby.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/09 - Lightnin' Hopkins - Katie Mae.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/08 - Lightnin' Hopkins - Back To New Orleans.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/07 - Lightnin' Hopkins - The Walkin' Blues.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/06 - Lightnin' Hopkins - Thinkin' 'Bout An Old Friend.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/05 - Lightnin' Hopkins - Come Back Baby.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/04 - Lightnin' Hopkins - Shinin' Moon.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Leb i Sol/Live In Macedonia/Disc 2/09 A Bre Makedonce - Leb I Sol.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Black River & Lela/Live at GAL club/CD1/02 All the things you are - Black River & Lela.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Black River & Lela/Live at GAL club/CD1/01 Old man from the old country - Black River & Lela.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/538977643 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/519700148 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/AZRA/Kao i jucer/CD1/05 Mon ami - AZRA.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/AZRA/Kao i jucer/CD1/04 Flash - AZRA.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Hugh Masekela - Hope/06 - Hugh Masekela - Until When.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Hugh Masekela - Hope/04 - Hugh Masekela - Grazin In The Grass.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Hugh Masekela - Hope/02 - Hugh Masekela - Uptownship.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/196421287 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/BIG BROTHER & THE HOLDING COMPANY - Cheap Thrills (MoFi)/07 - BIG BROTHER & THE HOLDING COMPANY - Ball And Chain.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/2871015 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/2871014 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/04 - Pink Floyd - Time.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/03 - Pink Floyd - On The Run.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/96869015 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/195978560 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/176121831 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/365229091 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/365062540 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534096173 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534096175 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534096174 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534096172 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534096171 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534096170 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534096169 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534096168 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534096167 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534098015 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534096166 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534095635 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534097133 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534097134 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534097138 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534097137 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534097136 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534097126 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534097532 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534752452 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534752451 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534752450 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534752442 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534752449 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534752448 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534752447 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534752446 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534752445 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534752444 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534752443 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: tidal://song/534673660 Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/07 - Al Di Meola - Meeting of the Spirits.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/06 - Al Di Meola - El Pañuelo.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/05 - Al Di Meola - Monasterio de Sal.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/04 - Al Di Meola - Trilogy Suite.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/03 - Al Di Meola - One Word.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/02 - Al Di Meola - Splendido Sundance.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/01 - Bill Graham - Bill Graham Introduction.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/HDTT24354 The Modern Jazz Quartet - The Comedy-DSF-11289k-1b/01-Spanish Steps.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Ella Fitzgerald, Louis Armstrong/HDTT24363 Ella Fitzgerald Sings Sweet Songs For Swingers-DSF-11289k-1b/01-Sweet and Lovely.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: https://stream.radioparadise.com/rock-flacm Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/King Crimson/1974 - King Crimson - Red (2009, 40th Anniversary Series, CD+DVD-A, KCSP7)/Original album - Starless.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/King Crimson/1974 - King Crimson - Red (2009, 40th Anniversary Series, CD+DVD-A, KCSP7)/Original album (Surround) - Starless.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/King Crimson/1974 - King Crimson - Red (2009, 40th Anniversary Series, CD+DVD-A, KCSP7)/Original album - Providence.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/King Crimson/1974 - King Crimson - Red (2009, 40th Anniversary Series, CD+DVD-A, KCSP7)/Original album (Surround) - Red.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Leb i Sol/Live In Macedonia/Disc 1/01 Raspukala Sar Planina - Leb i Sol.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Leb i Sol/Live In Macedonia/Disc 2/08 Uci Me Majko Karaj Me - Leb I Sol.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Leb i Sol/Live In Macedonia/Disc 2/03 Cuvam Noc Od Budnih - Leb I Sol.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Leb i Sol/Live In Macedonia/Disc 2/02 Jovano Jovanke - Leb I Sol.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Leb i Sol/Live In Macedonia/Disc 2/01 Bistra Voda - Leb I Sol.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1963) (Analogue Productions CPRJ 1073 SA) Goin' Away/01 - Lightnin' Hopkins - Wake Up Old Lady.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Miljenko Prohaska/Jazz glazba/CD2/06 Intima - Perpetuum Jazzile.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Miljenko Prohaska/Zabavna glazba/CD3/01 Razmisljanja - Revijski orkestar.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pankrti/Turneja Pomirenja - Live in Zagreb 1985/CD1/02 Pankrti - Turneja Pomirenja - Live in Zagreb 1985 - Bandiera Rossa.flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - Animals (2018 Remix)/02 - Pink Floyd - Dogs (2018 Remix).dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - Animals (2018 Remix)/01 - Pink Floyd - Pigs On The Wing 1 (2018 Remix).dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/10 - Pink Floyd - Eclipse.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/09 - Pink Floyd - Brain Damage.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/08 - Pink Floyd - Any Colour You Like.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/07 - Pink Floyd - Us And Them.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/06 - Pink Floyd - Money.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/05 - Pink Floyd - The Great Gig In The Sky.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/02 - Pink Floyd - Breathe (In The Air).dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/The Doors - The Soft Parade/Stereo/03 - Shaman's Blues.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/The Doors - Waiting For The Sun/Stereo/11 - Five To One.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/The Doors - Waiting For The Sun/Stereo/09 - We Could Be So Good Together.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/The Doors - Waiting For The Sun/Stereo/08 - My Wild Love.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/THE ABSOLUTE SOUND REFERENCE/For HiFi show and at home/Sound Library STS - Sound Recordings (Thunderstruck And Lightning).flac Oct 02 21:55:36 volumio volumio[1255]: info: Preloading song: mnt/USB/KINGSTON/THE ABSOLUTE SOUND REFERENCE/For HiFi show and at home/Accordion Duo - Old Irish Folk Song.flac Oct 02 21:55:36 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/03 - Lightnin' Hopkins - Mean Old Frisco.dsf in service mpd Oct 02 21:55:36 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/02 - Lightnin' Hopkins - You Better Watch Yourself.dsf in service mpd Oct 02 21:55:36 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Lightnin'%20Hopkins/Lightnin'/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLightnin'%20Hopkins%2FLightnin'%20Hopkins%20(1960)%20(Analogue%20Productions%20CPRJ%201019%20SA)%20Lightnin'%2F03%20-%20Lightnin'%20Hopkins%20-%20Mean%20Old%20Frisco.dsf&metadata=false Oct 02 21:55:36 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/03 - Lightnin' Hopkins - Mean Old Frisco.dsf Oct 02 21:55:36 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Lightnin'%20Hopkins/Lightnin'/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLightnin'%20Hopkins%2FLightnin'%20Hopkins%20(1960)%20(Analogue%20Productions%20CPRJ%201019%20SA)%20Lightnin'%2F02%20-%20Lightnin'%20Hopkins%20-%20You%20Better%20Watch%20Yourself.dsf&metadata=false Oct 02 21:55:36 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/02 - Lightnin' Hopkins - You Better Watch Yourself.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/01 - Lightnin' Hopkins - Automobile Blues.dsf in service mpd Oct 02 21:55:36 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Lightnin'%20Hopkins/Lightnin'/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLightnin'%20Hopkins%2FLightnin'%20Hopkins%20(1960)%20(Analogue%20Productions%20CPRJ%201019%20SA)%20Lightnin'%2F01%20-%20Lightnin'%20Hopkins%20-%20Automobile%20Blues.dsf&metadata=false Oct 02 21:55:36 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/01 - Lightnin' Hopkins - Automobile Blues.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/10 - Lightnin' Hopkins - Down There Baby.dsf in service mpd Oct 02 21:55:36 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Lightnin'%20Hopkins/Lightnin'/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLightnin'%20Hopkins%2FLightnin'%20Hopkins%20(1960)%20(Analogue%20Productions%20CPRJ%201019%20SA)%20Lightnin'%2F10%20-%20Lightnin'%20Hopkins%20-%20Down%20There%20Baby.dsf&metadata=false Oct 02 21:55:36 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/10 - Lightnin' Hopkins - Down There Baby.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/09 - Lightnin' Hopkins - Katie Mae.dsf in service mpd Oct 02 21:55:36 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Lightnin'%20Hopkins/Lightnin'/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLightnin'%20Hopkins%2FLightnin'%20Hopkins%20(1960)%20(Analogue%20Productions%20CPRJ%201019%20SA)%20Lightnin'%2F09%20-%20Lightnin'%20Hopkins%20-%20Katie%20Mae.dsf&metadata=false Oct 02 21:55:36 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/09 - Lightnin' Hopkins - Katie Mae.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/08 - Lightnin' Hopkins - Back To New Orleans.dsf in service mpd Oct 02 21:55:36 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Lightnin'%20Hopkins/Lightnin'/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLightnin'%20Hopkins%2FLightnin'%20Hopkins%20(1960)%20(Analogue%20Productions%20CPRJ%201019%20SA)%20Lightnin'%2F08%20-%20Lightnin'%20Hopkins%20-%20Back%20To%20New%20Orleans.dsf&metadata=false Oct 02 21:55:36 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/08 - Lightnin' Hopkins - Back To New Orleans.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/07 - Lightnin' Hopkins - The Walkin' Blues.dsf in service mpd Oct 02 21:55:36 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Lightnin'%20Hopkins/Lightnin'/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLightnin'%20Hopkins%2FLightnin'%20Hopkins%20(1960)%20(Analogue%20Productions%20CPRJ%201019%20SA)%20Lightnin'%2F07%20-%20Lightnin'%20Hopkins%20-%20The%20Walkin'%20Blues.dsf&metadata=false Oct 02 21:55:36 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/07 - Lightnin' Hopkins - The Walkin' Blues.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/06 - Lightnin' Hopkins - Thinkin' 'Bout An Old Friend.dsf in service mpd Oct 02 21:55:36 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Lightnin'%20Hopkins/Lightnin'/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLightnin'%20Hopkins%2FLightnin'%20Hopkins%20(1960)%20(Analogue%20Productions%20CPRJ%201019%20SA)%20Lightnin'%2F06%20-%20Lightnin'%20Hopkins%20-%20Thinkin'%20'Bout%20An%20Old%20Friend.dsf&metadata=false Oct 02 21:55:36 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/06 - Lightnin' Hopkins - Thinkin' 'Bout An Old Friend.dsf Oct 02 21:55:36 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/05 - Lightnin' Hopkins - Come Back Baby.dsf in service mpd Oct 02 21:55:36 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Lightnin'%20Hopkins/Lightnin'/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLightnin'%20Hopkins%2FLightnin'%20Hopkins%20(1960)%20(Analogue%20Productions%20CPRJ%201019%20SA)%20Lightnin'%2F05%20-%20Lightnin'%20Hopkins%20-%20Come%20Back%20Baby.dsf&metadata=false Oct 02 21:55:36 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/05 - Lightnin' Hopkins - Come Back Baby.dsf Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/04 - Lightnin' Hopkins - Shinin' Moon.dsf in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Lightnin'%20Hopkins/Lightnin'/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLightnin'%20Hopkins%2FLightnin'%20Hopkins%20(1960)%20(Analogue%20Productions%20CPRJ%201019%20SA)%20Lightnin'%2F04%20-%20Lightnin'%20Hopkins%20-%20Shinin'%20Moon.dsf&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Lightnin' Hopkins/Lightnin' Hopkins (1960) (Analogue Productions CPRJ 1019 SA) Lightnin'/04 - Lightnin' Hopkins - Shinin' Moon.dsf Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Leb i Sol/Live In Macedonia/Disc 2/09 A Bre Makedonce - Leb I Sol.flac in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Leb%20I%20Sol/Live%20In%20Macedonia%202/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLeb%20i%20Sol%2FLive%20In%20Macedonia%2FDisc%202%2F09%20A%20Bre%20Makedonce%20-%20Leb%20I%20Sol.flac&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Leb i Sol/Live In Macedonia/Disc 2/09 A Bre Makedonce - Leb I Sol.flac Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Black River & Lela/Live at GAL club/CD1/02 All the things you are - Black River & Lela.flac in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Black%20River%20%26%20Lela/Live%20at%20GAL%20club/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FBlack%20River%20%26%20Lela%2FLive%20at%20GAL%20club%2FCD1%2F02%20All%20the%20things%20you%20are%20-%20Black%20River%20%26%20Lela.flac&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Black River & Lela/Live at GAL club/CD1/02 All the things you are - Black River & Lela.flac Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Black River & Lela/Live at GAL club/CD1/01 Old man from the old country - Black River & Lela.flac in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Black%20River%20%26%20Lela/Live%20at%20GAL%20club/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FBlack%20River%20%26%20Lela%2FLive%20at%20GAL%20club%2FCD1%2F01%20Old%20man%20from%20the%20old%20country%20-%20Black%20River%20%26%20Lela.flac&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Black River & Lela/Live at GAL club/CD1/01 Old man from the old country - Black River & Lela.flac Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri tidal://song/538977643 in service tidal Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri tidal://song/519700148 in service tidal Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/AZRA/Kao i jucer/CD1/05 Mon ami - AZRA.flac in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Azra/Kao%20I%20Ju%C4%8Der%20(Single%20Plo%C4%8De%201983-86)/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAZRA%2FKao%20i%20jucer%2FCD1%2F05%20Mon%20ami%20-%20AZRA.flac&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/AZRA/Kao i jucer/CD1/05 Mon ami - AZRA.flac Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/AZRA/Kao i jucer/CD1/04 Flash - AZRA.flac in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Azra/Kao%20I%20Ju%C4%8Der%20(Single%20Plo%C4%8De%201983-86)/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAZRA%2FKao%20i%20jucer%2FCD1%2F04%20Flash%20-%20AZRA.flac&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/AZRA/Kao i jucer/CD1/04 Flash - AZRA.flac Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Hugh Masekela - Hope/06 - Hugh Masekela - Until When.dsf in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Hugh%20Masekela/Hope/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FHugh%20Masekela%20-%20Hope%2F06%20-%20Hugh%20Masekela%20-%20Until%20When.dsf&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Hugh Masekela - Hope/06 - Hugh Masekela - Until When.dsf Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Hugh Masekela - Hope/04 - Hugh Masekela - Grazin In The Grass.dsf in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Hugh%20Masekela/Hope/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FHugh%20Masekela%20-%20Hope%2F04%20-%20Hugh%20Masekela%20-%20Grazin%20In%20The%20Grass.dsf&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Hugh Masekela - Hope/04 - Hugh Masekela - Grazin In The Grass.dsf Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Hugh Masekela - Hope/02 - Hugh Masekela - Uptownship.dsf in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Hugh%20Masekela/Hope/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FHugh%20Masekela%20-%20Hope%2F02%20-%20Hugh%20Masekela%20-%20Uptownship.dsf&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Hugh Masekela - Hope/02 - Hugh Masekela - Uptownship.dsf Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri tidal://song/196421287 in service tidal Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/BIG BROTHER & THE HOLDING COMPANY - Cheap Thrills (MoFi)/07 - BIG BROTHER & THE HOLDING COMPANY - Ball And Chain.dsf in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=BIG%20BROTHER%20%26%20THE%20HOLDING%20COMPANY/Cheap%20Thrills/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FBIG%20BROTHER%20%26%20THE%20HOLDING%20COMPANY%20-%20Cheap%20Thrills%20(MoFi)%2F07%20-%20BIG%20BROTHER%20%26%20THE%20HOLDING%20COMPANY%20-%20Ball%20And%20Chain.dsf&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/BIG BROTHER & THE HOLDING COMPANY - Cheap Thrills (MoFi)/07 - BIG BROTHER & THE HOLDING COMPANY - Ball And Chain.dsf Oct 02 21:55:37 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:37 volumio volumio[1255]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri tidal://song/2871015 in service mpd Oct 02 21:55:37 volumio volumio[1255]: error: scanFolder - failure to stat '/mnt/tidal://song/2871015' Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri tidal://song/2871014 in service tidal Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/04 - Pink Floyd - Time.dsf in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: explodeTIDALUri took 554 milliseconds Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Pink%20Floyd/The%20Dark%20Side%20Of%20The%20Moon/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FPink%20Floyd%2FPink%20Floyd%20-%20The%20Dark%20Side%20Of%20The%20Moon%2F04%20-%20Pink%20Floyd%20-%20Time.dsf&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/04 - Pink Floyd - Time.dsf Oct 02 21:55:37 volumio volumio[1255]: info: explodeTIDALUri took 508 milliseconds Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/03 - Pink Floyd - On The Run.dsf in service mpd Oct 02 21:55:37 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Pink%20Floyd/The%20Dark%20Side%20Of%20The%20Moon/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FPink%20Floyd%2FPink%20Floyd%20-%20The%20Dark%20Side%20Of%20The%20Moon%2F03%20-%20Pink%20Floyd%20-%20On%20The%20Run.dsf&metadata=false Oct 02 21:55:37 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Pink Floyd/Pink Floyd - The Dark Side Of The Moon/03 - Pink Floyd - On The Run.dsf Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri tidal://song/96869015 in service tidal Oct 02 21:55:37 volumio volumio[1255]: info: explodeTIDALUri took 330 milliseconds Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri tidal://song/195978560 in service tidal Oct 02 21:55:37 volumio volumio[1255]: info: Exploding uri tidal://song/176121831 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/365229091 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/365062540 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 363 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 188 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 196 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534096173 in service mpd Oct 02 21:55:38 volumio volumio[1255]: error: scanFolder - failure to stat '/mnt/tidal://song/534096173' Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534096175 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 218 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534096174 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534096172 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534096171 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 182 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534096170 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 306 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 359 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 198 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534096169 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 184 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534096168 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 171 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534096167 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 184 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534098015 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534096166 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 205 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 176 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534095635 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 192 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534097133 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 171 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534097134 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 174 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534097138 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 189 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534097137 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 183 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534097136 in service tidal Oct 02 21:55:38 volumio volumio[1255]: info: explodeTIDALUri took 180 milliseconds Oct 02 21:55:38 volumio volumio[1255]: info: Exploding uri tidal://song/534097126 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 195 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534097532 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 182 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534752452 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 181 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534752451 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 186 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534752450 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 180 milliseconds Oct 02 21:55:39 volumio volumio[1255]: error: TIDAL Browse Error: failed to get track: got 404: {"status":404,"subStatus":2001,"userMessage":"Track [534097532] not found"} Oct 02 21:55:39 volumio volumio[1255]: error: Commandrouter: Cannot explode uri tidal://song/534097532 from service tidal: failed to get track: got 404: {"status":404,"subStatus":2001,"userMessage":"Track [534097532] not found"} Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534752442 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 182 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534752449 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 182 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534752448 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 169 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534752447 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534752446 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 211 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 183 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534752445 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 180 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534752444 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 172 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534752443 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 187 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri tidal://song/534673660 in service tidal Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 184 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/07 - Al Di Meola - Meeting of the Spirits.dsf in service mpd Oct 02 21:55:39 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Al%20Di%20Meola%20-%20John%20McLaughlin%20-%20Paco%20De%20Lucia/Saturday%20Night%20in%20San%20Francisco/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAl%20Di%20Meola%2FAl%20Di%20Meola%20-%20Saturday%20Night%20in%20San%20Francisco%2F07%20-%20Al%20Di%20Meola%20-%20Meeting%20of%20the%20Spirits.dsf&metadata=false Oct 02 21:55:39 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/07 - Al Di Meola - Meeting of the Spirits.dsf Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 194 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/06 - Al Di Meola - El Pañuelo.dsf in service mpd Oct 02 21:55:39 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Al%20Di%20Meola%20-%20John%20McLaughlin%20-%20Paco%20De%20Lucia/Saturday%20Night%20in%20San%20Francisco/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAl%20Di%20Meola%2FAl%20Di%20Meola%20-%20Saturday%20Night%20in%20San%20Francisco%2F06%20-%20Al%20Di%20Meola%20-%20El%20Pa%C3%B1uelo.dsf&metadata=false Oct 02 21:55:39 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/06 - Al Di Meola - El Pañuelo.dsf Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 176 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/05 - Al Di Meola - Monasterio de Sal.dsf in service mpd Oct 02 21:55:39 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Al%20Di%20Meola%20-%20John%20McLaughlin%20-%20Paco%20De%20Lucia/Saturday%20Night%20in%20San%20Francisco/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAl%20Di%20Meola%2FAl%20Di%20Meola%20-%20Saturday%20Night%20in%20San%20Francisco%2F05%20-%20Al%20Di%20Meola%20-%20Monasterio%20de%20Sal.dsf&metadata=false Oct 02 21:55:39 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/05 - Al Di Meola - Monasterio de Sal.dsf Oct 02 21:55:39 volumio volumio[1255]: info: explodeTIDALUri took 181 milliseconds Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/04 - Al Di Meola - Trilogy Suite.dsf in service mpd Oct 02 21:55:39 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Al%20Di%20Meola%20-%20John%20McLaughlin%20-%20Paco%20De%20Lucia/Saturday%20Night%20in%20San%20Francisco/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAl%20Di%20Meola%2FAl%20Di%20Meola%20-%20Saturday%20Night%20in%20San%20Francisco%2F04%20-%20Al%20Di%20Meola%20-%20Trilogy%20Suite.dsf&metadata=false Oct 02 21:55:39 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/04 - Al Di Meola - Trilogy Suite.dsf Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/03 - Al Di Meola - One Word.dsf in service mpd Oct 02 21:55:39 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Al%20Di%20Meola%20-%20John%20McLaughlin%20-%20Paco%20De%20Lucia/Saturday%20Night%20in%20San%20Francisco/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAl%20Di%20Meola%2FAl%20Di%20Meola%20-%20Saturday%20Night%20in%20San%20Francisco%2F03%20-%20Al%20Di%20Meola%20-%20One%20Word.dsf&metadata=false Oct 02 21:55:39 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/03 - Al Di Meola - One Word.dsf Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/02 - Al Di Meola - Splendido Sundance.dsf in service mpd Oct 02 21:55:39 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Al%20Di%20Meola%20-%20John%20McLaughlin%20-%20Paco%20De%20Lucia/Saturday%20Night%20in%20San%20Francisco/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAl%20Di%20Meola%2FAl%20Di%20Meola%20-%20Saturday%20Night%20in%20San%20Francisco%2F02%20-%20Al%20Di%20Meola%20-%20Splendido%20Sundance.dsf&metadata=false Oct 02 21:55:39 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/02 - Al Di Meola - Splendido Sundance.dsf Oct 02 21:55:39 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/01 - Bill Graham - Bill Graham Introduction.dsf in service mpd Oct 02 21:55:39 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Bill%20Graham/Saturday%20Night%20in%20San%20Francisco/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAl%20Di%20Meola%2FAl%20Di%20Meola%20-%20Saturday%20Night%20in%20San%20Francisco%2F01%20-%20Bill%20Graham%20-%20Bill%20Graham%20Introduction.dsf&metadata=false Oct 02 21:55:39 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Al Di Meola/Al Di Meola - Saturday Night in San Francisco/01 - Bill Graham - Bill Graham Introduction.dsf Oct 02 21:55:40 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/HDTT24354 The Modern Jazz Quartet - The Comedy-DSF-11289k-1b/01-Spanish Steps.dsf in service mpd Oct 02 21:55:40 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=The%20Modern%20Jazz%20Quartet/The%20Modern%20Jazz%20Quartet%20-%20The%20Comedy/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FHDTT24354%20The%20Modern%20Jazz%20Quartet%20-%20The%20Comedy-DSF-11289k-1b%2F01-Spanish%20Steps.dsf&metadata=false Oct 02 21:55:40 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/HDTT24354 The Modern Jazz Quartet - The Comedy-DSF-11289k-1b/01-Spanish Steps.dsf Oct 02 21:55:40 volumio volumio[1255]: info: Exploding uri mnt/USB/KINGSTON/Ella Fitzgerald, Louis Armstrong/HDTT24363 Ella Fitzgerald Sings Sweet Songs For Swingers-DSF-11289k-1b/01-Sweet and Lovely.dsf in service mpd Oct 02 21:55:40 volumio volumio[1255]: info: ALBUMART /albumart?cacheid=105&web=Ella%20Fitzgerald%20with%20Frank%20De%20Vol's%20Orchestra/Ella%20Fitzgerald%20Sings%20Sweet%20Songs%20For%20Swingers/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FElla%20Fitzgerald%2C%20Louis%20Armstrong%2FHDTT24363%20Ella%20Fitzgerald%20Sings%20Sweet%20Songs%20For%20Swingers-DSF-11289k-1b%2F01-Sweet%20and%20Lovely.dsf&metadata=false Oct 02 21:55:40 volumio volumio[1255]: info: URI /mnt/USB/KINGSTON/Ella Fitzgerald, Louis Armstrong/HDTT24363 Ella Fitzgerald Sings Sweet Songs For Swingers-DSF-11289k-1b/01-Sweet and Lovely.dsf Oct 02 21:55:40 volumio volumio[1255]: info: Exploding uri https://stream.radioparadise.com/rock-flacm in service radio_paradise Oct 02 21:55:40 volumio volumio[1255]: error: [RadioParadise] explodeUri: No station found for uri "https://stream.radioparadise.com/rock-flacm" Oct 02 21:55:40 volumio volumio[1255]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 21:55:40 volumio volumio[1255]: TypeError: Cannot read properties of undefined (reading 'then') Oct 02 21:55:40 volumio volumio[1255]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:31) Oct 02 21:55:40 volumio volumio[1255]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Oct 02 21:55:40 volumio volumio[1255]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Oct 02 21:55:40 volumio volumio[1255]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) Oct 02 21:55:40 volumio volumio[1255]: at listOnTimeout (node:internal/timers:573:17) Oct 02 21:55:40 volumio volumio[1255]: at process.processTimers (node:internal/timers:514:7) Oct 02 21:55:40 volumio volumio[1255]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 21:55:41 volumio sudo[8413]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-02 21:54' Oct 02 21:55:41 volumio sudo[8413]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"