-- Logs begin at Fri 2025-12-12 03:49:59 AEDT, end at Wed 2025-12-31 15:35:17 AEDT. -- Dec 31 15:34:02 volumio kernel: hwmon hwmon1: Voltage normalised Dec 31 15:34:05 volumio kernel: hwmon hwmon1: Undervoltage detected! Dec 31 15:34:38 volumio volumio[954]: info: Dec 31 15:34:38 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:34:38 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:34:38 volumio volumio[954]: info: Dec 31 15:34:38 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:34:38 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:34:38 volumio volumio[954]: info: Dec 31 15:34:38 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:34:38 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:34:38 volumio volumio[954]: info: Dec 31 15:34:38 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:34:38 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:34:38 volumio volumio[954]: info: Dec 31 15:34:38 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:34:38 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:34:38 volumio volumio[954]: info: Dec 31 15:34:38 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:34:38 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:34:38 volumio volumio[954]: info: ------------------------------ 18ms Dec 31 15:34:38 volumio volumio[954]: info: sendMpdCommand status took 15 milliseconds Dec 31 15:34:38 volumio volumio[954]: info: ------------------------------ 13ms Dec 31 15:34:38 volumio volumio[954]: info: sendMpdCommand status took 11 milliseconds Dec 31 15:34:38 volumio volumio[954]: info: ------------------------------ 10ms Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:34:38 volumio volumio[954]: info: sendMpdCommand status took 12 milliseconds Dec 31 15:34:38 volumio volumio[954]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 31 15:34:38 volumio volumio[954]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:34:38 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:34:38 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:34:38 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:34:38 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":117851,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"John Farnham - A Touch of Paradise","artist":"SMOOTHRELAX_SYD","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/SMOOTHRELAX_SYD.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&gdpr=0&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTc2NzE1NTQ4NSwiaXNzIjoidGlzcnYifQ.GC3yUSRDpbV4r-ioo7VCzRpVUBeLuaPhr1pk9f0Kfxk","trackType":""} Dec 31 15:34:38 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:34:38 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:34:38 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 15:34:38 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:34:38 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:34:38 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:34:38 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:34:38 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:34:38 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":117851,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"John Farnham - A Touch of Paradise","artist":"SMOOTHRELAX_SYD","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/SMOOTHRELAX_SYD.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&gdpr=0&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTc2NzE1NTQ4NSwiaXNzIjoidGlzcnYifQ.GC3yUSRDpbV4r-ioo7VCzRpVUBeLuaPhr1pk9f0Kfxk","trackType":""} Dec 31 15:34:38 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:34:38 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:34:38 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:34:38 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:34:38 volumio volumio[954]: info: ------------------------------ 117ms Dec 31 15:34:38 volumio volumio[954]: info: ------------------------------ 112ms Dec 31 15:34:38 volumio volumio[954]: info: sendMpdCommand playlistinfo took 80 milliseconds Dec 31 15:34:38 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:34:38 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:34:38 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:34:38 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:34:38 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":117851,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"John Farnham - A Touch of Paradise","artist":"SMOOTHRELAX_SYD","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/SMOOTHRELAX_SYD.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&gdpr=0&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTc2NzE1NTQ4NSwiaXNzIjoidGlzcnYifQ.GC3yUSRDpbV4r-ioo7VCzRpVUBeLuaPhr1pk9f0Kfxk","trackType":""} Dec 31 15:34:38 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:34:38 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:34:38 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 15:34:38 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:34:38 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:34:38 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:34:38 volumio volumio[954]: info: ------------------------------ 148ms Dec 31 15:35:11 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 31 15:35:12 volumio volumio[954]: info: Preload queue cleared Dec 31 15:35:13 volumio volumio[954]: info: Preload queue cleared Dec 31 15:35:13 volumio volumio[954]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::ClearQueue Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::stop Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::stPlaybackTimer Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::updateTrackBlock Dec 31 15:35:13 volumio volumio[954]: info: CorePlayQueue::getTrackBlock Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:13 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:13 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 15:35:13 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::serviceStop Dec 31 15:35:13 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:13 volumio volumio[954]: info: CoreCommandRouter::serviceStop Dec 31 15:35:13 volumio volumio[954]: info: [1767155713232] ControllerWebradio::stop Dec 31 15:35:13 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand stop Dec 31 15:35:13 volumio volumio[954]: info: CorePlayQueue::clearPlayQueue Dec 31 15:35:13 volumio volumio[954]: info: CorePlayQueue::saveQueue Dec 31 15:35:13 volumio volumio[954]: info: CoreCommandRouter::volumioPushQueue Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::addQueueItems Dec 31 15:35:13 volumio volumio[954]: info: CorePlayQueue::addQueueItems Dec 31 15:35:13 volumio volumio[954]: info: Preload queue cleared Dec 31 15:35:13 volumio volumio[954]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99502244 Dec 31 15:35:13 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 31 15:35:13 volumio volumio[954]: info: CoreCommandRouter::volumioPushQueue Dec 31 15:35:13 volumio volumio[954]: info: CorePlayQueue::saveQueue Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::updateTrackBlock Dec 31 15:35:13 volumio volumio[954]: info: CorePlayQueue::getTrackBlock Dec 31 15:35:13 volumio volumio[954]: info: CoreCommandRouter::volumioPlay Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::play index 0 Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::stop Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::play index undefined Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 31 15:35:13 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:13 volumio volumio[954]: info: CoreStateMachine::startPlaybackTimer Dec 31 15:35:13 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:13 volumio volumio[954]: info: [1767155713272] ControllerWebradio::clearAddPlayTrack Dec 31 15:35:13 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand stop Dec 31 15:35:13 volumio volumio[954]: info: Dec 31 15:35:13 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:13 volumio volumio[954]: info: sendMpdCommand stop took 54 milliseconds Dec 31 15:35:13 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:13 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:13 volumio volumio[954]: info: sendMpdCommand stop took 16 milliseconds Dec 31 15:35:13 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand clear Dec 31 15:35:13 volumio volumio[954]: info: Dec 31 15:35:13 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:35:13 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:35:13 volumio volumio[954]: info: sendMpdCommand status took 5 milliseconds Dec 31 15:35:13 volumio volumio[954]: info: sendMpdCommand clear took 4 milliseconds Dec 31 15:35:13 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:13 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:13 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99502244" Dec 31 15:35:13 volumio volumio[954]: info: Dec 31 15:35:13 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:13 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:13 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:13 volumio volumio[954]: info: Dec 31 15:35:13 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:13 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:13 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:13 volumio volumio[954]: error: updateQueue error: null Dec 31 15:35:13 volumio volumio[954]: info: ------------------------------ 13ms Dec 31 15:35:13 volumio volumio[954]: info: sendMpdCommand playlistinfo took 9 milliseconds Dec 31 15:35:13 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:13 volumio volumio[954]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 31 15:35:13 volumio volumio[954]: info: ------------------------------ 22ms Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99502244" took 796 milliseconds Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand play Dec 31 15:35:14 volumio volumio[954]: info: Dec 31 15:35:14 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:35:14 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand status took 796 milliseconds Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand status took 795 milliseconds Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 31 15:35:14 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState stateService stop Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus stop Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: No code Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 31 15:35:14 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState stateService stop Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus stop Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: No code Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: ------------------------------ 894ms Dec 31 15:35:14 volumio volumio[954]: info: ------------------------------ 893ms Dec 31 15:35:14 volumio volumio[954]: info: Dec 31 15:35:14 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:35:14 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:35:14 volumio volumio[954]: info: Dec 31 15:35:14 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:35:14 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand play took 109 milliseconds Dec 31 15:35:14 volumio volumio[954]: info: ------------------------------ 109ms Dec 31 15:35:14 volumio volumio[954]: info: ------------------------------ 7ms Dec 31 15:35:14 volumio volumio[954]: info: ------------------------------ 5ms Dec 31 15:35:14 volumio volumio[954]: info: Dec 31 15:35:14 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:14 volumio volumio[954]: info: Dec 31 15:35:14 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:14 volumio volumio[954]: info: Dec 31 15:35:14 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand status took 61 milliseconds Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:14 volumio volumio[954]: info: Dec 31 15:35:14 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand status took 65 milliseconds Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand status took 63 milliseconds Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"109.199.99.246:7202","artist":"(#1 - 2/200) Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:14 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus stop Dec 31 15:35:14 volumio volumio[954]: info: ------------------------------ 77ms Dec 31 15:35:14 volumio volumio[954]: info: Dec 31 15:35:14 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:14 volumio volumio[954]: info: Dec 31 15:35:14 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand status took 15 milliseconds Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand playlistinfo took 13 milliseconds Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand playlistinfo took 13 milliseconds Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand status took 7 milliseconds Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand status took 5 milliseconds Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"109.199.99.246:7202","artist":"(#1 - 2/200) Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:14 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:35:14 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"109.199.99.246:7202","artist":"(#1 - 2/200) Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:14 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:35:14 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: ------------------------------ 155ms Dec 31 15:35:14 volumio volumio[954]: info: ------------------------------ 154ms Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand playlistinfo took 72 milliseconds Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand playlistinfo took 71 milliseconds Dec 31 15:35:14 volumio volumio[954]: info: sendMpdCommand playlistinfo took 71 milliseconds Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:14 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"109.199.99.246:7202","artist":"(#1 - 2/200) Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:14 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:35:14 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"109.199.99.246:7202","artist":"(#1 - 2/200) Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:14 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:35:14 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"109.199.99.246:7202","artist":"(#1 - 2/200) Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:14 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:35:14 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:14 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:14 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 190ms Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 181ms Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 180ms Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:35:15 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:35:15 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:35:15 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:35:15 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 22ms Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand status took 21 milliseconds Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 21ms Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand status took 17 milliseconds Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 16ms Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand status took 14 milliseconds Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:35:15 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces system playlist update Dec 31 15:35:15 volumio volumio[954]: info: Ignoring MPD Status Update Dec 31 15:35:15 volumio volumio[954]: info: Dec 31 15:35:15 volumio volumio[954]: ---------------------------- MPD announces state update: player Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::getState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand status Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 28ms Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand status took 24 milliseconds Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 14ms Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand status took 12 milliseconds Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 11ms Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand status took 9 milliseconds Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseState Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:15 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:15 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The After Party - Bujaj Się","artist":"Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:15 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:35:15 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:15 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:15 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The After Party - Bujaj Się","artist":"Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:15 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:35:15 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:15 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:15 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The After Party - Bujaj Się","artist":"Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:15 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:35:15 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 153ms Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 151ms Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 145ms Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand playlistinfo took 109 milliseconds Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand playlistinfo took 105 milliseconds Dec 31 15:35:15 volumio volumio[954]: info: sendMpdCommand playlistinfo took 106 milliseconds Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:15 volumio volumio[954]: verbose: ControllerMpd::parseTrackInfo Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:15 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:15 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The After Party - Bujaj Się","artist":"Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:15 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:35:15 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:15 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:15 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The After Party - Bujaj Się","artist":"Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:15 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:35:15 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: ControllerMpd::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::servicePushState Dec 31 15:35:15 volumio volumio[954]: info: CorePlayQueue::getTrack 0 Dec 31 15:35:15 volumio volumio[954]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The After Party - Bujaj Się","artist":"Radyo Magkaisa 98.1 FM","album":null,"uri":"http://109.199.99.246:7202","trackType":"246:7202"} Dec 31 15:35:15 volumio volumio[954]: verbose: CURRENT POSITION 0 Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState stateService play Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::syncState currentStatus play Dec 31 15:35:15 volumio volumio[954]: info: Received an update from plugin. extracting info from payload Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: CoreStateMachine::pushState Dec 31 15:35:15 volumio volumio[954]: info: CoreCommandRouter::volumioPushState Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 239ms Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 223ms Dec 31 15:35:15 volumio volumio[954]: info: ------------------------------ 221ms Dec 31 15:35:15 volumio volumio[954]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 31 15:35:15 volumio volumio[954]: Error: connect ECONNREFUSED 0.0.0.0:443 Dec 31 15:35:15 volumio volumio[954]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Dec 31 15:35:15 volumio volumio[954]: errno: -111, Dec 31 15:35:15 volumio volumio[954]: code: 'ECONNREFUSED', Dec 31 15:35:15 volumio volumio[954]: syscall: 'connect', Dec 31 15:35:15 volumio volumio[954]: address: '0.0.0.0', Dec 31 15:35:15 volumio volumio[954]: port: 443 Dec 31 15:35:15 volumio volumio[954]: } Dec 31 15:35:15 volumio volumio[954]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 31 15:35:17 volumio sudo[5457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-31 15:34 Dec 31 15:35:17 volumio sudo[5457]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"