-- Logs begin at Tue 2025-05-20 10:37:20 UTC, end at Sun 2025-06-15 12:52:16 UTC. -- Jun 15 12:51:00 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 15 12:51:00 volumio2 volumio[757]: info: Getting webradio selection Jun 15 12:51:03 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand add "http://c15.radioboss.fm:8167/stream" Jun 15 12:51:03 volumio2 volumio[757]: info: Jun 15 12:51:03 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:03 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:03 volumio2 volumio[757]: info: sendMpdCommand add "http://c15.radioboss.fm:8167/stream" took 17 milliseconds Jun 15 12:51:03 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 15 12:51:03 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand play Jun 15 12:51:03 volumio2 volumio[757]: info: ------------------------------ 48ms Jun 15 12:51:03 volumio2 volumio[757]: info: sendMpdCommand play took 32 milliseconds Jun 15 12:51:07 volumio2 volumio[757]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::ClearQueue Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::stop Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:07 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:07 volumio2 volumio[757]: info: CorePlayQueue::clearPlayQueue Jun 15 12:51:07 volumio2 volumio[757]: info: CorePlayQueue::saveQueue Jun 15 12:51:07 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:07 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:07 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushQueue Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::addQueueItems Jun 15 12:51:07 volumio2 volumio[757]: info: CorePlayQueue::addQueueItems Jun 15 12:51:07 volumio2 volumio[757]: info: Adding Item to queue: http://stream.srg-ssr.ch/m/rsc_de/aacp_96 Jun 15 12:51:07 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 15 12:51:07 volumio2 volumio[757]: info: CorePlayQueue::saveQueue Jun 15 12:51:07 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushQueue Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::updateTrackBlock Jun 15 12:51:07 volumio2 volumio[757]: info: CorePlayQueue::getTrackBlock Jun 15 12:51:07 volumio2 volumio[757]: info: CoreCommandRouter::volumioPlay Jun 15 12:51:07 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::play index 0 Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::stop Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:07 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::play index undefined Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:07 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:07 volumio2 volumio[757]: info: CoreStateMachine::startPlaybackTimer Jun 15 12:51:07 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:07 volumio2 volumio[757]: info: [1749991867902] ControllerWebradio::clearAddPlayTrack Jun 15 12:51:07 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand stop Jun 15 12:51:07 volumio2 volumio[757]: info: Jun 15 12:51:07 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:08 volumio2 volumio[757]: info: sendMpdCommand stop took 92 milliseconds Jun 15 12:51:08 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:08 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:08 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand clear Jun 15 12:51:08 volumio2 volumio[757]: info: Jun 15 12:51:08 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:08 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:08 volumio2 volumio[757]: info: sendMpdCommand status took 36 milliseconds Jun 15 12:51:08 volumio2 volumio[757]: info: sendMpdCommand clear took 37 milliseconds Jun 15 12:51:08 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:08 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:08 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand load "http://stream.srg-ssr.ch/m/rsc_de/aacp_96" Jun 15 12:51:08 volumio2 volumio[757]: error: updateQueue error: null Jun 15 12:51:08 volumio2 volumio[757]: info: ------------------------------ 48ms Jun 15 12:51:08 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 30 milliseconds Jun 15 12:51:08 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:08 volumio2 volumio[757]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 15 12:51:08 volumio2 volumio[757]: info: ------------------------------ 114ms Jun 15 12:51:10 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand add "http://stream.srg-ssr.ch/m/rsc_de/aacp_96" Jun 15 12:51:10 volumio2 volumio[757]: info: Jun 15 12:51:10 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:10 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:10 volumio2 volumio[757]: info: sendMpdCommand add "http://stream.srg-ssr.ch/m/rsc_de/aacp_96" took 19 milliseconds Jun 15 12:51:10 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 15 12:51:10 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand play Jun 15 12:51:10 volumio2 volumio[757]: info: ------------------------------ 50ms Jun 15 12:51:10 volumio2 volumio[757]: info: sendMpdCommand play took 37 milliseconds Jun 15 12:51:12 volumio2 volumio[757]: info: Jun 15 12:51:13 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:13 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:13 volumio2 kernel: bcm2835-i2s 20203000.i2s: I2S SYNC error! Jun 15 12:51:13 volumio2 volumio[757]: info: Jun 15 12:51:13 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:13 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:13 volumio2 volumio[757]: info: Jun 15 12:51:13 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:13 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:13 volumio2 volumio[757]: info: sendMpdCommand status took 68 milliseconds Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:13 volumio2 volumio[757]: info: sendMpdCommand status took 56 milliseconds Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:13 volumio2 volumio[757]: info: ------------------------------ 73ms Jun 15 12:51:13 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 57 milliseconds Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:13 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:51:13 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:51:13 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:13 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":469,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"aacp_96","artist":"Swiss Classic D","album":null,"uri":"http://stream.srg-ssr.ch/m/rsc_de/aacp_96","trackType":""} Jun 15 12:51:13 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:51:13 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:51:13 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus stop Jun 15 12:51:13 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:13 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:13 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:13 volumio2 volumio[757]: info: ------------------------------ 283ms Jun 15 12:51:13 volumio2 volumio[757]: info: Jun 15 12:51:13 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:13 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:13 volumio2 volumio[757]: info: Jun 15 12:51:13 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:13 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 198 milliseconds Jun 15 12:51:13 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:13 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:51:13 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:51:13 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:13 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":469,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"95 Kbps","isStreaming":false,"title":"aacp_96","artist":"Swiss Classic D","album":null,"uri":"http://stream.srg-ssr.ch/m/rsc_de/aacp_96","trackType":""} Jun 15 12:51:13 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:51:13 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:51:13 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus play Jun 15 12:51:13 volumio2 volumio[757]: info: Received an update from plugin. extracting info from payload Jun 15 12:51:13 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:13 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:13 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:13 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:13 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:13 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:13 volumio2 volumio[757]: info: ------------------------------ 523ms Jun 15 12:51:13 volumio2 volumio[757]: info: ------------------------------ 386ms Jun 15 12:51:13 volumio2 volumio[757]: info: sendMpdCommand status took 367 milliseconds Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:13 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 131 milliseconds Jun 15 12:51:13 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:13 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:51:13 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:51:13 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:13 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":725,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"102 Kbps","isStreaming":false,"title":"Philippe Gaubert - Tarantelle","artist":"Swiss Classic D","album":null,"uri":"http://stream.srg-ssr.ch/m/rsc_de/aacp_96","trackType":""} Jun 15 12:51:13 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:51:13 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:51:13 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus play Jun 15 12:51:13 volumio2 volumio[757]: info: Received an update from plugin. extracting info from payload Jun 15 12:51:13 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:13 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:13 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:14 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:14 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:14 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:14 volumio2 volumio[757]: info: ------------------------------ 763ms Jun 15 12:51:26 volumio2 volumio[757]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 15 12:51:26 volumio2 volumio[757]: info: CoreStateMachine::ClearQueue Jun 15 12:51:26 volumio2 volumio[757]: info: CoreStateMachine::stop Jun 15 12:51:26 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:26 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:26 volumio2 volumio[757]: info: CoreStateMachine::stPlaybackTimer Jun 15 12:51:26 volumio2 volumio[757]: info: CoreStateMachine::updateTrackBlock Jun 15 12:51:26 volumio2 volumio[757]: info: CorePlayQueue::getTrackBlock Jun 15 12:51:26 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:26 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:26 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:26 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:26 volumio2 volumio[757]: info: CoreStateMachine::serviceStop Jun 15 12:51:26 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:26 volumio2 volumio[757]: info: CoreCommandRouter::serviceStop Jun 15 12:51:26 volumio2 volumio[757]: info: [1749991886786] ControllerWebradio::stop Jun 15 12:51:26 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand stop Jun 15 12:51:26 volumio2 volumio[757]: info: CorePlayQueue::clearPlayQueue Jun 15 12:51:26 volumio2 volumio[757]: info: CorePlayQueue::saveQueue Jun 15 12:51:26 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:26 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:26 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushQueue Jun 15 12:51:26 volumio2 volumio[757]: info: CoreStateMachine::addQueueItems Jun 15 12:51:26 volumio2 volumio[757]: info: CorePlayQueue::addQueueItems Jun 15 12:51:26 volumio2 volumio[757]: info: Adding Item to queue: http://media-ice.musicradio.com/ClassicFMMP3 Jun 15 12:51:26 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 15 12:51:26 volumio2 volumio[757]: info: CorePlayQueue::saveQueue Jun 15 12:51:26 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushQueue Jun 15 12:51:27 volumio2 volumio[757]: info: CoreStateMachine::updateTrackBlock Jun 15 12:51:27 volumio2 volumio[757]: info: CorePlayQueue::getTrackBlock Jun 15 12:51:27 volumio2 volumio[757]: info: CoreCommandRouter::volumioPlay Jun 15 12:51:27 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:27 volumio2 volumio[757]: info: CoreStateMachine::play index 0 Jun 15 12:51:27 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:27 volumio2 volumio[757]: info: CoreStateMachine::stop Jun 15 12:51:27 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:27 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:27 volumio2 volumio[757]: info: CoreStateMachine::play index undefined Jun 15 12:51:27 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:27 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:27 volumio2 volumio[757]: info: CoreStateMachine::startPlaybackTimer Jun 15 12:51:27 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:27 volumio2 volumio[757]: info: [1749991887065] ControllerWebradio::clearAddPlayTrack Jun 15 12:51:27 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand stop Jun 15 12:51:27 volumio2 volumio[757]: info: Jun 15 12:51:27 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:27 volumio2 volumio[757]: info: sendMpdCommand stop took 373 milliseconds Jun 15 12:51:27 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:27 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:27 volumio2 volumio[757]: info: sendMpdCommand stop took 110 milliseconds Jun 15 12:51:27 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand clear Jun 15 12:51:27 volumio2 volumio[757]: info: Jun 15 12:51:27 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:27 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:27 volumio2 volumio[757]: info: sendMpdCommand status took 39 milliseconds Jun 15 12:51:27 volumio2 volumio[757]: info: sendMpdCommand clear took 29 milliseconds Jun 15 12:51:27 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:27 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:27 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand load "http://media-ice.musicradio.com/ClassicFMMP3" Jun 15 12:51:27 volumio2 volumio[757]: error: updateQueue error: null Jun 15 12:51:27 volumio2 volumio[757]: info: ------------------------------ 99ms Jun 15 12:51:27 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 78 milliseconds Jun 15 12:51:27 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:27 volumio2 volumio[757]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 15 12:51:27 volumio2 volumio[757]: info: ------------------------------ 158ms Jun 15 12:51:28 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand add "http://media-ice.musicradio.com/ClassicFMMP3" Jun 15 12:51:28 volumio2 volumio[757]: info: Jun 15 12:51:28 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:28 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:28 volumio2 volumio[757]: info: sendMpdCommand add "http://media-ice.musicradio.com/ClassicFMMP3" took 14 milliseconds Jun 15 12:51:28 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 15 12:51:28 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand play Jun 15 12:51:28 volumio2 volumio[757]: info: ------------------------------ 44ms Jun 15 12:51:28 volumio2 volumio[757]: info: sendMpdCommand play took 28 milliseconds Jun 15 12:51:28 volumio2 volumio[757]: info: Jun 15 12:51:28 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:28 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:28 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:28 volumio2 volumio[757]: info: Jun 15 12:51:28 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:28 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:28 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:28 volumio2 volumio[757]: info: sendMpdCommand status took 51 milliseconds Jun 15 12:51:28 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:28 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:28 volumio2 volumio[757]: info: Jun 15 12:51:28 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:28 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:28 volumio2 volumio[757]: info: sendMpdCommand status took 49 milliseconds Jun 15 12:51:28 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 26 milliseconds Jun 15 12:51:28 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:28 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:28 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:28 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:51:28 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:51:28 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:28 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Johann Sebastian Bach, Isabelle Faust - Concerto in D minor for 2 Violins (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jun 15 12:51:28 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:51:28 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:51:28 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus stop Jun 15 12:51:29 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:29 volumio2 volumio[757]: info: ------------------------------ 215ms Jun 15 12:51:29 volumio2 volumio[757]: info: Jun 15 12:51:29 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:29 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:29 volumio2 volumio[757]: info: Jun 15 12:51:29 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:29 volumio2 volumio[757]: info: ------------------------------ 162ms Jun 15 12:51:29 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 145 milliseconds Jun 15 12:51:29 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:29 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:29 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:29 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:51:29 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:29 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":499,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Johann Sebastian Bach, Isabelle Faust - Concerto in D minor for 2 Violins (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jun 15 12:51:29 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:51:29 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:51:29 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus play Jun 15 12:51:29 volumio2 volumio[757]: info: Received an update from plugin. extracting info from payload Jun 15 12:51:29 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:29 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:29 volumio2 volumio[757]: info: ------------------------------ 568ms Jun 15 12:51:29 volumio2 volumio[757]: info: ------------------------------ 559ms Jun 15 12:51:29 volumio2 volumio[757]: info: sendMpdCommand status took 539 milliseconds Jun 15 12:51:29 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:29 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:29 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 15 milliseconds Jun 15 12:51:29 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:29 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:51:29 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:29 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":684,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Johann Sebastian Bach, Isabelle Faust - Concerto in D minor for 2 Violins (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jun 15 12:51:29 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:51:29 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:51:29 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus play Jun 15 12:51:29 volumio2 volumio[757]: info: Received an update from plugin. extracting info from payload Jun 15 12:51:29 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:29 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:29 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:29 volumio2 volumio[757]: info: ------------------------------ 912ms Jun 15 12:51:30 volumio2 volumio[757]: info: Jun 15 12:51:30 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:30 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:30 volumio2 volumio[757]: info: Jun 15 12:51:30 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:30 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:30 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:30 volumio2 volumio[757]: info: ------------------------------ 49ms Jun 15 12:51:30 volumio2 volumio[757]: info: sendMpdCommand status took 29 milliseconds Jun 15 12:51:30 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:30 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:30 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 19 milliseconds Jun 15 12:51:30 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:30 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:51:30 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:51:30 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:30 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1988,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Johann Sebastian Bach, Isabelle Faust - Concerto in D minor for 2 Violins (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jun 15 12:51:30 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:51:30 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:51:30 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus play Jun 15 12:51:30 volumio2 volumio[757]: info: Received an update from plugin. extracting info from payload Jun 15 12:51:30 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:30 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:30 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:30 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:30 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:30 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:30 volumio2 volumio[757]: info: ------------------------------ 230ms Jun 15 12:51:32 volumio2 volumio[757]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::ClearQueue Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::stop Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:32 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::stPlaybackTimer Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::updateTrackBlock Jun 15 12:51:32 volumio2 volumio[757]: info: CorePlayQueue::getTrackBlock Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:32 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:32 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:32 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::serviceStop Jun 15 12:51:32 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:32 volumio2 volumio[757]: info: CoreCommandRouter::serviceStop Jun 15 12:51:32 volumio2 volumio[757]: info: [1749991892288] ControllerWebradio::stop Jun 15 12:51:32 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand stop Jun 15 12:51:32 volumio2 volumio[757]: info: CorePlayQueue::clearPlayQueue Jun 15 12:51:32 volumio2 volumio[757]: info: CorePlayQueue::saveQueue Jun 15 12:51:32 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:32 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:32 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushQueue Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::addQueueItems Jun 15 12:51:32 volumio2 volumio[757]: info: CorePlayQueue::addQueueItems Jun 15 12:51:32 volumio2 volumio[757]: info: Adding Item to queue: http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3 Jun 15 12:51:32 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 15 12:51:32 volumio2 volumio[757]: info: CorePlayQueue::saveQueue Jun 15 12:51:32 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushQueue Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::updateTrackBlock Jun 15 12:51:32 volumio2 volumio[757]: info: CorePlayQueue::getTrackBlock Jun 15 12:51:32 volumio2 volumio[757]: info: CoreCommandRouter::volumioPlay Jun 15 12:51:32 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::play index 0 Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::stop Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:32 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::play index undefined Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:32 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:32 volumio2 volumio[757]: info: CoreStateMachine::startPlaybackTimer Jun 15 12:51:32 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:32 volumio2 volumio[757]: info: [1749991892505] ControllerWebradio::clearAddPlayTrack Jun 15 12:51:32 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand stop Jun 15 12:51:32 volumio2 volumio[757]: info: Jun 15 12:51:32 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:32 volumio2 volumio[757]: info: sendMpdCommand stop took 317 milliseconds Jun 15 12:51:32 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:32 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:32 volumio2 volumio[757]: info: sendMpdCommand stop took 113 milliseconds Jun 15 12:51:32 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand clear Jun 15 12:51:32 volumio2 volumio[757]: info: Jun 15 12:51:32 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:32 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:32 volumio2 volumio[757]: info: sendMpdCommand status took 35 milliseconds Jun 15 12:51:32 volumio2 volumio[757]: info: sendMpdCommand clear took 30 milliseconds Jun 15 12:51:32 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:32 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:32 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand load "http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3" Jun 15 12:51:32 volumio2 volumio[757]: error: updateQueue error: null Jun 15 12:51:32 volumio2 volumio[757]: info: ------------------------------ 75ms Jun 15 12:51:32 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 51 milliseconds Jun 15 12:51:32 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:32 volumio2 volumio[757]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 15 12:51:32 volumio2 volumio[757]: info: ------------------------------ 131ms Jun 15 12:51:33 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand add "http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3" Jun 15 12:51:33 volumio2 volumio[757]: info: Jun 15 12:51:33 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:33 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:33 volumio2 volumio[757]: info: sendMpdCommand add "http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3" took 16 milliseconds Jun 15 12:51:33 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 15 12:51:33 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand play Jun 15 12:51:33 volumio2 volumio[757]: info: ------------------------------ 44ms Jun 15 12:51:33 volumio2 volumio[757]: info: sendMpdCommand play took 34 milliseconds Jun 15 12:51:34 volumio2 volumio[757]: info: Jun 15 12:51:34 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:34 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:34 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:34 volumio2 volumio[757]: info: Jun 15 12:51:34 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:34 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:34 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:34 volumio2 volumio[757]: info: Jun 15 12:51:34 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:34 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:34 volumio2 volumio[757]: info: sendMpdCommand status took 49 milliseconds Jun 15 12:51:34 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:34 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:34 volumio2 volumio[757]: info: sendMpdCommand status took 50 milliseconds Jun 15 12:51:34 volumio2 volumio[757]: info: ------------------------------ 44ms Jun 15 12:51:34 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 28 milliseconds Jun 15 12:51:34 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:34 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:34 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:34 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:51:34 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:51:34 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:34 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":490,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"francemusiqueclassiqueplus-midfi.mp3","artist":"francemusiqueclassiqueplus-midfi.mp3","album":null,"uri":"http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3","trackType":"mp3"} Jun 15 12:51:34 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:51:34 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:51:34 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus stop Jun 15 12:51:34 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:34 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:34 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:34 volumio2 volumio[757]: info: ------------------------------ 236ms Jun 15 12:51:34 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 134 milliseconds Jun 15 12:51:34 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:34 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:51:34 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:51:34 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:34 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":490,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"francemusiqueclassiqueplus-midfi.mp3","artist":"francemusiqueclassiqueplus-midfi.mp3","album":null,"uri":"http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3","trackType":"mp3"} Jun 15 12:51:34 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:51:34 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:51:34 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus play Jun 15 12:51:34 volumio2 volumio[757]: info: Received an update from plugin. extracting info from payload Jun 15 12:51:34 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:34 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:34 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:34 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:34 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:34 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:34 volumio2 volumio[757]: info: ------------------------------ 425ms Jun 15 12:51:50 volumio2 volumio[757]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::ClearQueue Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::stop Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:50 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::stPlaybackTimer Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::updateTrackBlock Jun 15 12:51:50 volumio2 volumio[757]: info: CorePlayQueue::getTrackBlock Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:50 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:50 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:50 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::serviceStop Jun 15 12:51:50 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:50 volumio2 volumio[757]: info: CoreCommandRouter::serviceStop Jun 15 12:51:50 volumio2 volumio[757]: info: [1749991910234] ControllerWebradio::stop Jun 15 12:51:50 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand stop Jun 15 12:51:50 volumio2 volumio[757]: info: CorePlayQueue::clearPlayQueue Jun 15 12:51:50 volumio2 volumio[757]: info: CorePlayQueue::saveQueue Jun 15 12:51:50 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:50 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:50 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushQueue Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::addQueueItems Jun 15 12:51:50 volumio2 volumio[757]: info: CorePlayQueue::addQueueItems Jun 15 12:51:50 volumio2 volumio[757]: info: Adding Item to queue: http://mscp3.live-streams.nl:8250/class-flac.flac Jun 15 12:51:50 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 15 12:51:50 volumio2 volumio[757]: info: CorePlayQueue::saveQueue Jun 15 12:51:50 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushQueue Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::updateTrackBlock Jun 15 12:51:50 volumio2 volumio[757]: info: CorePlayQueue::getTrackBlock Jun 15 12:51:50 volumio2 volumio[757]: info: CoreCommandRouter::volumioPlay Jun 15 12:51:50 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::play index 0 Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::stop Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:50 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::play index undefined Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:50 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:50 volumio2 volumio[757]: info: CoreStateMachine::startPlaybackTimer Jun 15 12:51:50 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:50 volumio2 volumio[757]: info: [1749991910426] ControllerWebradio::clearAddPlayTrack Jun 15 12:51:50 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand stop Jun 15 12:51:50 volumio2 volumio[757]: info: Jun 15 12:51:50 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:50 volumio2 volumio[757]: info: sendMpdCommand stop took 308 milliseconds Jun 15 12:51:50 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:50 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:50 volumio2 volumio[757]: info: sendMpdCommand stop took 115 milliseconds Jun 15 12:51:50 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand clear Jun 15 12:51:50 volumio2 volumio[757]: info: Jun 15 12:51:50 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:50 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:50 volumio2 volumio[757]: info: sendMpdCommand status took 39 milliseconds Jun 15 12:51:50 volumio2 volumio[757]: info: sendMpdCommand clear took 32 milliseconds Jun 15 12:51:50 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:50 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:50 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand load "http://mscp3.live-streams.nl:8250/class-flac.flac" Jun 15 12:51:50 volumio2 volumio[757]: error: updateQueue error: null Jun 15 12:51:50 volumio2 volumio[757]: info: ------------------------------ 69ms Jun 15 12:51:50 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 51 milliseconds Jun 15 12:51:50 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:50 volumio2 volumio[757]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 15 12:51:50 volumio2 volumio[757]: info: ------------------------------ 127ms Jun 15 12:51:51 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand add "http://mscp3.live-streams.nl:8250/class-flac.flac" Jun 15 12:51:51 volumio2 volumio[757]: info: Jun 15 12:51:51 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:51 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:51 volumio2 volumio[757]: info: sendMpdCommand add "http://mscp3.live-streams.nl:8250/class-flac.flac" took 15 milliseconds Jun 15 12:51:51 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 15 12:51:51 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand play Jun 15 12:51:51 volumio2 volumio[757]: info: ------------------------------ 45ms Jun 15 12:51:51 volumio2 volumio[757]: info: sendMpdCommand play took 36 milliseconds Jun 15 12:51:53 volumio2 volumio[757]: info: Jun 15 12:51:53 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:53 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:53 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:53 volumio2 volumio[757]: info: Jun 15 12:51:53 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:51:53 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:51:53 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:51:53 volumio2 volumio[757]: info: Jun 15 12:51:53 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:51:53 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:51:53 volumio2 volumio[757]: info: sendMpdCommand status took 61 milliseconds Jun 15 12:51:53 volumio2 volumio[757]: info: sendMpdCommand status took 48 milliseconds Jun 15 12:51:53 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:53 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:53 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:51:53 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:51:53 volumio2 volumio[757]: info: ------------------------------ 75ms Jun 15 12:51:53 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 46 milliseconds Jun 15 12:51:53 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:53 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:51:53 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:51:53 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:53 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":"Naim Classical","album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"} Jun 15 12:51:53 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:51:53 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:51:53 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus stop Jun 15 12:51:53 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:53 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:53 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:53 volumio2 volumio[757]: info: ------------------------------ 234ms Jun 15 12:51:53 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 167 milliseconds Jun 15 12:51:53 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:51:53 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:51:53 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:51:53 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:53 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":"Naim Classical","album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"} Jun 15 12:51:53 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:51:53 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:51:53 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus play Jun 15 12:51:53 volumio2 volumio[757]: info: Received an update from plugin. extracting info from payload Jun 15 12:51:53 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:53 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:53 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:53 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:53 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:53 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:53 volumio2 volumio[757]: info: ------------------------------ 458ms Jun 15 12:51:59 volumio2 volumio[757]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 15 12:51:59 volumio2 volumio[757]: info: CoreStateMachine::ClearQueue Jun 15 12:51:59 volumio2 volumio[757]: info: CoreStateMachine::stop Jun 15 12:51:59 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:51:59 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:51:59 volumio2 volumio[757]: info: CoreStateMachine::stPlaybackTimer Jun 15 12:51:59 volumio2 volumio[757]: info: CoreStateMachine::updateTrackBlock Jun 15 12:51:59 volumio2 volumio[757]: info: CorePlayQueue::getTrackBlock Jun 15 12:51:59 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:51:59 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:59 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:51:59 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:51:59 volumio2 volumio[757]: info: CoreStateMachine::serviceStop Jun 15 12:51:59 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:51:59 volumio2 volumio[757]: info: CoreCommandRouter::serviceStop Jun 15 12:51:59 volumio2 volumio[757]: info: [1749991919933] ControllerWebradio::stop Jun 15 12:51:59 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand stop Jun 15 12:52:00 volumio2 volumio[757]: info: CorePlayQueue::clearPlayQueue Jun 15 12:52:00 volumio2 volumio[757]: info: CorePlayQueue::saveQueue Jun 15 12:52:00 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:52:00 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:52:00 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushQueue Jun 15 12:52:00 volumio2 volumio[757]: info: CoreStateMachine::addQueueItems Jun 15 12:52:00 volumio2 volumio[757]: info: CorePlayQueue::addQueueItems Jun 15 12:52:00 volumio2 volumio[757]: info: Adding Item to queue: http://stream.srg-ssr.ch/m/rsc_de/aacp_96 Jun 15 12:52:00 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 15 12:52:00 volumio2 volumio[757]: info: CorePlayQueue::saveQueue Jun 15 12:52:00 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushQueue Jun 15 12:52:00 volumio2 volumio[757]: info: CoreStateMachine::updateTrackBlock Jun 15 12:52:00 volumio2 volumio[757]: info: CorePlayQueue::getTrackBlock Jun 15 12:52:00 volumio2 volumio[757]: info: CoreCommandRouter::volumioPlay Jun 15 12:52:00 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:52:00 volumio2 volumio[757]: info: CoreStateMachine::play index 0 Jun 15 12:52:00 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:52:00 volumio2 volumio[757]: info: CoreStateMachine::stop Jun 15 12:52:00 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:52:00 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:52:00 volumio2 volumio[757]: info: CoreStateMachine::play index undefined Jun 15 12:52:00 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:52:00 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:52:00 volumio2 volumio[757]: info: CoreStateMachine::startPlaybackTimer Jun 15 12:52:00 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:52:00 volumio2 volumio[757]: info: [1749991920136] ControllerWebradio::clearAddPlayTrack Jun 15 12:52:00 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand stop Jun 15 12:52:00 volumio2 volumio[757]: info: Jun 15 12:52:00 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:52:00 volumio2 volumio[757]: info: sendMpdCommand stop took 347 milliseconds Jun 15 12:52:00 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:52:00 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:52:00 volumio2 volumio[757]: info: sendMpdCommand stop took 154 milliseconds Jun 15 12:52:00 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand clear Jun 15 12:52:00 volumio2 volumio[757]: info: Jun 15 12:52:00 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:52:00 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:52:00 volumio2 volumio[757]: info: sendMpdCommand status took 33 milliseconds Jun 15 12:52:00 volumio2 volumio[757]: info: sendMpdCommand clear took 25 milliseconds Jun 15 12:52:00 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:52:00 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:52:00 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand load "http://stream.srg-ssr.ch/m/rsc_de/aacp_96" Jun 15 12:52:00 volumio2 volumio[757]: error: updateQueue error: null Jun 15 12:52:00 volumio2 volumio[757]: info: ------------------------------ 74ms Jun 15 12:52:00 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 56 milliseconds Jun 15 12:52:00 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:52:00 volumio2 volumio[757]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 15 12:52:00 volumio2 volumio[757]: info: ------------------------------ 137ms Jun 15 12:52:02 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand add "http://stream.srg-ssr.ch/m/rsc_de/aacp_96" Jun 15 12:52:02 volumio2 volumio[757]: info: Jun 15 12:52:02 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:52:02 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:52:02 volumio2 volumio[757]: info: sendMpdCommand add "http://stream.srg-ssr.ch/m/rsc_de/aacp_96" took 15 milliseconds Jun 15 12:52:02 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 15 12:52:02 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand play Jun 15 12:52:02 volumio2 volumio[757]: info: ------------------------------ 48ms Jun 15 12:52:02 volumio2 volumio[757]: info: sendMpdCommand play took 30 milliseconds Jun 15 12:52:03 volumio2 volumio[757]: info: Jun 15 12:52:03 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:52:03 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:52:03 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:52:03 volumio2 volumio[757]: info: Jun 15 12:52:03 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:52:03 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:52:03 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:52:03 volumio2 volumio[757]: info: Jun 15 12:52:03 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:52:03 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:52:04 volumio2 volumio[757]: info: sendMpdCommand status took 45 milliseconds Jun 15 12:52:04 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:52:04 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:52:04 volumio2 volumio[757]: info: sendMpdCommand status took 78 milliseconds Jun 15 12:52:04 volumio2 volumio[757]: info: ------------------------------ 67ms Jun 15 12:52:04 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 41 milliseconds Jun 15 12:52:04 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:52:04 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:52:04 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:52:04 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:52:04 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:52:04 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":469,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"105 Kbps","isStreaming":false,"title":"aacp_96","artist":"Swiss Classic D","album":null,"uri":"http://stream.srg-ssr.ch/m/rsc_de/aacp_96","trackType":""} Jun 15 12:52:04 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:52:04 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:52:04 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus stop Jun 15 12:52:04 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:52:04 volumio2 volumio[757]: info: ------------------------------ 267ms Jun 15 12:52:04 volumio2 volumio[757]: info: Jun 15 12:52:04 volumio2 volumio[757]: ---------------------------- MPD announces system playlist update Jun 15 12:52:04 volumio2 volumio[757]: info: Ignoring MPD Status Update Jun 15 12:52:04 volumio2 volumio[757]: info: Jun 15 12:52:04 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:52:04 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 162 milliseconds Jun 15 12:52:04 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:52:04 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:52:04 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:52:04 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:52:04 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:52:04 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":469,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"89 Kbps","isStreaming":false,"title":"aacp_96","artist":"Swiss Classic D","album":null,"uri":"http://stream.srg-ssr.ch/m/rsc_de/aacp_96","trackType":""} Jun 15 12:52:04 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:52:04 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:52:04 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus play Jun 15 12:52:04 volumio2 volumio[757]: info: Received an update from plugin. extracting info from payload Jun 15 12:52:04 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:52:04 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:52:04 volumio2 volumio[757]: info: ------------------------------ 513ms Jun 15 12:52:04 volumio2 volumio[757]: info: ------------------------------ 397ms Jun 15 12:52:04 volumio2 volumio[757]: info: sendMpdCommand status took 377 milliseconds Jun 15 12:52:04 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:52:04 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:52:04 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 34 milliseconds Jun 15 12:52:04 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:52:04 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:52:04 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:52:04 volumio2 volumio[757]: verbose: STATE SERVICE {"status":"play","position":0,"seek":725,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"88 Kbps","isStreaming":false,"title":"Philippe Gaubert - Tarantelle","artist":"Swiss Classic D","album":null,"uri":"http://stream.srg-ssr.ch/m/rsc_de/aacp_96","trackType":""} Jun 15 12:52:04 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:52:04 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService play Jun 15 12:52:04 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus play Jun 15 12:52:04 volumio2 volumio[757]: info: Received an update from plugin. extracting info from payload Jun 15 12:52:04 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:52:04 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:52:04 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:52:04 volumio2 volumio[757]: info: ------------------------------ 658ms Jun 15 12:52:06 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Jun 15 12:52:08 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Jun 15 12:52:09 volumio2 volumio[757]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 15 12:52:09 volumio2 volumio[757]: info: CoreStateMachine::ClearQueue Jun 15 12:52:09 volumio2 volumio[757]: info: CoreStateMachine::stop Jun 15 12:52:09 volumio2 volumio[757]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 15 12:52:09 volumio2 volumio[757]: UNSET VOLATILE Jun 15 12:52:09 volumio2 volumio[757]: info: CoreStateMachine::stPlaybackTimer Jun 15 12:52:09 volumio2 volumio[757]: info: CoreStateMachine::updateTrackBlock Jun 15 12:52:09 volumio2 volumio[757]: info: CorePlayQueue::getTrackBlock Jun 15 12:52:09 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:52:09 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:52:09 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:52:09 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:52:09 volumio2 volumio[757]: info: CoreStateMachine::serviceStop Jun 15 12:52:09 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:52:09 volumio2 volumio[757]: info: CoreCommandRouter::serviceStop Jun 15 12:52:09 volumio2 volumio[757]: info: [1749991929617] ControllerWebradio::stop Jun 15 12:52:09 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand stop Jun 15 12:52:09 volumio2 volumio[757]: info: CorePlayQueue::clearPlayQueue Jun 15 12:52:09 volumio2 volumio[757]: info: CorePlayQueue::saveQueue Jun 15 12:52:09 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:52:09 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:52:09 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushQueue Jun 15 12:52:09 volumio2 volumio[757]: info: CoreStateMachine::addQueueItems Jun 15 12:52:09 volumio2 volumio[757]: info: CorePlayQueue::addQueueItems Jun 15 12:52:09 volumio2 volumio[757]: info: Adding Item to queue: webkbs/0 Jun 15 12:52:09 volumio2 volumio[757]: info: Exploding uri webkbs/0 in service personal_radio Jun 15 12:52:10 volumio2 volumio[757]: info: Jun 15 12:52:10 volumio2 volumio[757]: ---------------------------- MPD announces state update: player Jun 15 12:52:10 volumio2 volumio[757]: info: sendMpdCommand stop took 439 milliseconds Jun 15 12:52:10 volumio2 volumio[757]: info: ControllerMpd::getState Jun 15 12:52:10 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand status Jun 15 12:52:10 volumio2 volumio[757]: info: sendMpdCommand status took 31 milliseconds Jun 15 12:52:10 volumio2 volumio[757]: verbose: ControllerMpd::parseState Jun 15 12:52:10 volumio2 volumio[757]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 15 12:52:10 volumio2 volumio[757]: info: sendMpdCommand playlistinfo took 33 milliseconds Jun 15 12:52:10 volumio2 volumio[757]: verbose: ControllerMpd::parseTrackInfo Jun 15 12:52:10 volumio2 volumio[757]: info: ControllerMpd::pushState Jun 15 12:52:10 volumio2 volumio[757]: info: CoreCommandRouter::servicePushState Jun 15 12:52:10 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:52:10 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:52:10 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:52:10 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:52:10 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:52:10 volumio2 volumio[757]: 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":"Philippe Gaubert - Tarantelle","artist":"Swiss Classic D","album":null,"uri":"http://stream.srg-ssr.ch/m/rsc_de/aacp_96","trackType":""} Jun 15 12:52:10 volumio2 volumio[757]: verbose: CURRENT POSITION 0 Jun 15 12:52:10 volumio2 volumio[757]: info: CoreStateMachine::syncState stateService stop Jun 15 12:52:10 volumio2 volumio[757]: info: CoreStateMachine::syncState currentStatus stop Jun 15 12:52:10 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:52:10 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:52:10 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:52:10 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:52:10 volumio2 volumio[757]: info: No code Jun 15 12:52:10 volumio2 volumio[757]: info: CoreStateMachine::pushState Jun 15 12:52:10 volumio2 volumio[757]: info: CorePlayQueue::getTrack 0 Jun 15 12:52:10 volumio2 volumio[757]: info: CoreCommandRouter::volumioPushState Jun 15 12:52:10 volumio2 volumio[757]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 12:52:10 volumio2 volumio[757]: info: ------------------------------ 413ms Jun 15 12:52:11 volumio2 volumio[757]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 15 12:52:11 volumio2 volumio[757]: ReferenceError: self is not defined Jun 15 12:52:11 volumio2 volumio[757]: at ControllerPersonalRadio.errorToast (/data/plugins/music_service/personal_radio/index.js:575:22) Jun 15 12:52:11 volumio2 volumio[757]: at /data/plugins/music_service/personal_radio/index.js:487:12 Jun 15 12:52:11 volumio2 volumio[757]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:355:15) Jun 15 12:52:11 volumio2 volumio[757]: at self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22) Jun 15 12:52:11 volumio2 volumio[757]: at emitOne (events.js:116:13) Jun 15 12:52:11 volumio2 volumio[757]: at Request.emit (events.js:211:7) Jun 15 12:52:11 volumio2 volumio[757]: at Request.onRequestError (/data/plugins/music_service/personal_radio/node_modules/request/request.js:813:8) Jun 15 12:52:11 volumio2 volumio[757]: at emitOne (events.js:116:13) Jun 15 12:52:11 volumio2 volumio[757]: at ClientRequest.emit (events.js:211:7) Jun 15 12:52:11 volumio2 volumio[757]: at Socket.socketErrorListener (_http_client.js:387:9) Jun 15 12:52:11 volumio2 volumio[757]: at emitOne (events.js:116:13) Jun 15 12:52:11 volumio2 volumio[757]: at Socket.emit (events.js:211:7) Jun 15 12:52:11 volumio2 volumio[757]: at emitErrorNT (internal/streams/destroy.js:64:8) Jun 15 12:52:11 volumio2 volumio[757]: at _combinedTickCallback (internal/process/next_tick.js:138:11) Jun 15 12:52:11 volumio2 volumio[757]: at process._tickCallback (internal/process/next_tick.js:180:9) Jun 15 12:52:11 volumio2 volumio[757]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 15 12:52:16 volumio2 sudo[27329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-15 12:51 Jun 15 12:52:16 volumio2 sudo[27329]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="e81b2037a65d8f554cb0c857a1007d659ad7f838" VOLUMIO_FE_VERSION="e489037accd8e0b2dcbd6e0b054400d8cd36d4e2" VOLUMIO_BE_VERSION="25875b197c75cd1ac7eb5664d94cdd19afb06985" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Feb 19 17:39:10 CET 2021" VOLUMIO_VERSION="2.873" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="781d4c9fbf86d562939968306a6a26f4"