Jul 05 11:04:06 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::ClearQueue Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::stPlaybackTimer Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::updateTrackBlock Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::getTrackBlock Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::serviceStop Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::serviceStop Jul 05 11:04:06 volumio volumio[1081]: info: [1751706246427] ControllerWebradio::stop Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::clearPlayQueue Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::addQueueItems Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::addQueueItems Jul 05 11:04:06 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:04:06 volumio volumio[1081]: info: Adding Item to queue: http://mscp3.live-streams.nl:8340/jazz-flac.flac Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::updateTrackBlock Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::getTrackBlock Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::volumioPlay Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::play index 0 Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::play index undefined Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::startPlaybackTimer Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:06 volumio volumio[1081]: info: [1751706246437] ControllerWebradio::clearAddPlayTrack Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:06 volumio volumio[1081]: info: Jul 05 11:04:06 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:06 volumio volumio[1081]: info: sendMpdCommand stop took 15 milliseconds Jul 05 11:04:06 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:06 volumio volumio[1081]: info: sendMpdCommand stop took 6 milliseconds Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 11:04:06 volumio volumio[1081]: info: Jul 05 11:04:06 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:06 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:06 volumio volumio[1081]: info: Jul 05 11:04:06 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:06 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:06 volumio volumio[1081]: info: Jul 05 11:04:06 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:04:06 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:04:06 volumio volumio[1081]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:04:06 volumio volumio[1081]: info: sendMpdCommand clear took 4 milliseconds Jul 05 11:04:06 volumio volumio[1081]: info: sendMpdCommand status took 3 milliseconds Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand load "http://mscp3.live-streams.nl:8340/jazz-flac.flac" Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:06 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:06 volumio volumio[1081]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 05 11:04:06 volumio volumio[1081]: info: ------------------------------ 9ms Jul 05 11:04:06 volumio volumio[1081]: info: Jul 05 11:04:06 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:04:06 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:04:06 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:04:06 volumio volumio[1081]: info: sendMpdCommand status took 10 milliseconds Jul 05 11:04:06 volumio volumio[1081]: info: ------------------------------ 10ms Jul 05 11:04:06 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 8 milliseconds Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:06 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:04:06 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:04:06 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:04:06 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:06 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:06 volumio volumio[1081]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 05 11:04:06 volumio volumio[1081]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jul 05 11:04:06 volumio volumio[1081]: info: ------------------------------ 17ms Jul 05 11:04:06 volumio volumio[1081]: info: ------------------------------ 20ms Jul 05 11:04:06 volumio volumio[1081]: info: Jul 05 11:04:06 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:04:06 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:06 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:07 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:04:07 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand add "http://mscp3.live-streams.nl:8340/jazz-flac.flac" Jul 05 11:04:07 volumio volumio[1081]: info: ------------------------------ 758ms Jul 05 11:04:07 volumio volumio[1081]: info: ------------------------------ 749ms Jul 05 11:04:07 volumio volumio[1081]: info: Jul 05 11:04:07 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:04:07 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand add "http://mscp3.live-streams.nl:8340/jazz-flac.flac" took 3 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand play Jul 05 11:04:07 volumio volumio[1081]: info: Jul 05 11:04:07 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:04:07 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:04:07 volumio volumio[1081]: info: Jul 05 11:04:07 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:04:07 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:04:07 volumio volumio[1081]: info: ------------------------------ 4ms Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand play took 3 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: ------------------------------ 4ms Jul 05 11:04:07 volumio volumio[1081]: info: ------------------------------ 3ms Jul 05 11:04:07 volumio volumio[1081]: info: Jul 05 11:04:07 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:07 volumio volumio[1081]: info: Jul 05 11:04:07 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:07 volumio volumio[1081]: info: Jul 05 11:04:07 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:07 volumio volumio[1081]: info: Jul 05 11:04:07 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand status took 21 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand status took 20 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand status took 20 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:04:07 volumio volumio[1081]: info: Jul 05 11:04:07 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:07 volumio volumio[1081]: info: Jul 05 11:04:07 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand status took 7 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:04:07 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:07 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:04:07 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:04:07 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:07 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:04:07 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:04:07 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:04:07 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:07 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:04:07 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:04:07 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:07 volumio volumio[1081]: info: ------------------------------ 47ms Jul 05 11:04:07 volumio volumio[1081]: info: ------------------------------ 50ms Jul 05 11:04:07 volumio volumio[1081]: info: ------------------------------ 51ms Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 22 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 17 milliseconds Jul 05 11:04:07 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:04:07 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:04:07 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:07 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:04:07 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:04:07 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:04:07 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:07 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:04:07 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:04:07 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:07 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:04:07 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:07 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:04:07 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:04:07 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:07 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:07 volumio volumio[1081]: info: ------------------------------ 50ms Jul 05 11:04:07 volumio volumio[1081]: info: ------------------------------ 47ms Jul 05 11:04:07 volumio volumio[1081]: info: ------------------------------ 45ms Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:07 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:08 volumio volumio[1081]: info: Jul 05 11:04:08 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:04:08 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:04:08 volumio volumio[1081]: info: Jul 05 11:04:08 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:08 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:08 volumio volumio[1081]: info: Jul 05 11:04:08 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:04:08 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:04:08 volumio volumio[1081]: info: Jul 05 11:04:08 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:08 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:08 volumio volumio[1081]: info: Jul 05 11:04:08 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:04:08 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:04:08 volumio volumio[1081]: info: Jul 05 11:04:08 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:04:08 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:04:08 volumio volumio[1081]: info: ------------------------------ 6ms Jul 05 11:04:08 volumio volumio[1081]: info: sendMpdCommand status took 6 milliseconds Jul 05 11:04:08 volumio volumio[1081]: info: ------------------------------ 6ms Jul 05 11:04:08 volumio volumio[1081]: info: sendMpdCommand status took 5 milliseconds Jul 05 11:04:08 volumio volumio[1081]: info: ------------------------------ 5ms Jul 05 11:04:08 volumio volumio[1081]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:04:08 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 05 11:04:08 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 05 11:04:08 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:04:08 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:04:08 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:04:08 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:04:08 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:08 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":"Naim Jazz","album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:04:08 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:04:08 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:08 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:08 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:04:08 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:08 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:08 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:04:08 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:04:08 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:08 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":"Naim Jazz","album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:04:08 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:04:08 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:08 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:08 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:08 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:08 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:04:08 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:04:08 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:08 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":"Naim Jazz","album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:04:08 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:04:08 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:08 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:04:08 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:08 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:04:08 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:04:08 volumio volumio[1081]: info: ------------------------------ 22ms Jul 05 11:04:08 volumio volumio[1081]: info: ------------------------------ 21ms Jul 05 11:04:08 volumio volumio[1081]: info: ------------------------------ 21ms Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:04:08 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:04:49 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jul 05 11:04:49 volumio dbus-daemon[597]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.40728' (uid=0 pid=9865 comm="timedatectl show --property=NTPSynchronized --valu") Jul 05 11:04:49 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jul 05 11:04:49 volumio dbus-daemon[597]: [system] Successfully activated service 'org.freedesktop.timedate1' Jul 05 11:04:49 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jul 05 11:04:49 volumio setdatetime-helper.sh[9864]: Time is already synchronized. Jul 05 11:04:49 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jul 05 11:04:49 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jul 05 11:05:17 volumio nmbd[918]: [2025/07/05 11:05:17.077630, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 05 11:05:17 volumio nmbd[918]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.10.194 for name WORKGROUP<1d>. Jul 05 11:05:17 volumio nmbd[918]: This response was from IP 192.168.10.164, reporting an IP address of 192.168.10.164. Jul 05 11:05:18 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::ClearQueue Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::stPlaybackTimer Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::updateTrackBlock Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrackBlock Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::serviceStop Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::serviceStop Jul 05 11:05:18 volumio volumio[1081]: info: [1751706318921] ControllerWebradio::stop Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::clearPlayQueue Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::addQueueItems Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::addQueueItems Jul 05 11:05:18 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:05:18 volumio volumio[1081]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s104484&filter=s:g11:country Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:18 volumio volumio[1081]: info: Jul 05 11:05:18 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:18 volumio volumio[1081]: info: sendMpdCommand stop took 40 milliseconds Jul 05 11:05:18 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:18 volumio volumio[1081]: info: Jul 05 11:05:18 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:18 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:18 volumio volumio[1081]: info: Jul 05 11:05:18 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:18 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:18 volumio volumio[1081]: info: sendMpdCommand status took 3 milliseconds Jul 05 11:05:18 volumio volumio[1081]: info: sendMpdCommand status took 2 milliseconds Jul 05 11:05:18 volumio volumio[1081]: info: sendMpdCommand status took 1 milliseconds Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:18 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 11:05:18 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 05 11:05:18 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:18 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:18 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: 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":"jazz-flac.flac","artist":"Naim Jazz","album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:05:18 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:18 volumio volumio[1081]: info: No code Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:18 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: 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":"jazz-flac.flac","artist":"Naim Jazz","album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:05:18 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:18 volumio volumio[1081]: info: No code Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:18 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: 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":"jazz-flac.flac","artist":"Naim Jazz","album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"} Jul 05 11:05:18 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:18 volumio volumio[1081]: info: No code Jul 05 11:05:18 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:18 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:18 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:18 volumio volumio[1081]: info: ------------------------------ 29ms Jul 05 11:05:18 volumio volumio[1081]: info: ------------------------------ 29ms Jul 05 11:05:18 volumio volumio[1081]: info: ------------------------------ 28ms Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:18 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:19 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:19 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:05:19 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:05:19 volumio volumio[1081]: info: CoreStateMachine::updateTrackBlock Jul 05 11:05:19 volumio volumio[1081]: info: CorePlayQueue::getTrackBlock Jul 05 11:05:19 volumio volumio[1081]: info: CoreCommandRouter::volumioPlay Jul 05 11:05:19 volumio volumio[1081]: info: CoreStateMachine::play index 0 Jul 05 11:05:19 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:19 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:05:19 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:19 volumio volumio[1081]: info: CoreStateMachine::play index undefined Jul 05 11:05:19 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:19 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:19 volumio volumio[1081]: info: CoreStateMachine::startPlaybackTimer Jul 05 11:05:19 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:19 volumio volumio[1081]: info: [1751706319241] ControllerWebradio::clearAddPlayTrack Jul 05 11:05:19 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:05:19 volumio volumio[1081]: info: sendMpdCommand stop took 2 milliseconds Jul 05 11:05:19 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 11:05:19 volumio volumio[1081]: info: Jul 05 11:05:19 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:19 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:19 volumio volumio[1081]: info: sendMpdCommand clear took 1 milliseconds Jul 05 11:05:19 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand load "https://radiojazz.out.airtime.pro/radiojazz_a" Jul 05 11:05:19 volumio volumio[1081]: info: Jul 05 11:05:19 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:19 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:19 volumio volumio[1081]: info: Jul 05 11:05:19 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:19 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:19 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:19 volumio volumio[1081]: info: ------------------------------ 3ms Jul 05 11:05:19 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jul 05 11:05:20 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:20 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:20 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand add "https://radiojazz.out.airtime.pro/radiojazz_a" Jul 05 11:05:20 volumio volumio[1081]: info: ------------------------------ 1446ms Jul 05 11:05:20 volumio volumio[1081]: info: ------------------------------ 1446ms Jul 05 11:05:20 volumio volumio[1081]: info: Jul 05 11:05:20 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:20 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:20 volumio volumio[1081]: info: sendMpdCommand add "https://radiojazz.out.airtime.pro/radiojazz_a" took 3 milliseconds Jul 05 11:05:20 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 05 11:05:20 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand play Jul 05 11:05:20 volumio volumio[1081]: info: Jul 05 11:05:20 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:20 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:20 volumio volumio[1081]: info: Jul 05 11:05:20 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:20 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:20 volumio volumio[1081]: info: ------------------------------ 5ms Jul 05 11:05:20 volumio volumio[1081]: info: sendMpdCommand play took 4 milliseconds Jul 05 11:05:20 volumio volumio[1081]: info: ------------------------------ 2ms Jul 05 11:05:20 volumio volumio[1081]: info: ------------------------------ 2ms Jul 05 11:05:21 volumio volumio[1081]: info: Jul 05 11:05:21 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:21 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:21 volumio volumio[1081]: info: Jul 05 11:05:21 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:21 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:21 volumio volumio[1081]: info: Jul 05 11:05:21 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:21 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:21 volumio volumio[1081]: info: Jul 05 11:05:21 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:21 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:21 volumio volumio[1081]: info: Jul 05 11:05:21 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand status took 6 milliseconds Jul 05 11:05:21 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand status took 6 milliseconds Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand status took 6 milliseconds Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand status took 7 milliseconds Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:21 volumio volumio[1081]: info: Jul 05 11:05:21 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:21 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand clearerror took 9 milliseconds Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand status took 8 milliseconds Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand clearerror took 8 milliseconds Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand clearerror took 7 milliseconds Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand clearerror took 6 milliseconds Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 05 11:05:21 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:21 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:21 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:21 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:21 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: No code Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:21 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:21 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: No code Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:21 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:21 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: No code Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:21 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:21 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: No code Jul 05 11:05:21 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:21 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:21 volumio volumio[1081]: info: ------------------------------ 44ms Jul 05 11:05:21 volumio volumio[1081]: info: ------------------------------ 44ms Jul 05 11:05:21 volumio volumio[1081]: info: ------------------------------ 44ms Jul 05 11:05:21 volumio volumio[1081]: info: ------------------------------ 44ms Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:21 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:22 volumio volumio[1081]: info: sendMpdCommand status took 48 milliseconds Jul 05 11:05:22 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 46 milliseconds Jul 05 11:05:22 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:22 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:22 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:22 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:22 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:22 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:22 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:22 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:22 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:22 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:22 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:22 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:22 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:22 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:22 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:22 volumio volumio[1081]: info: No code Jul 05 11:05:22 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:22 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:22 volumio volumio[1081]: info: ------------------------------ 66ms Jul 05 11:05:22 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 14 milliseconds Jul 05 11:05:22 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:22 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:22 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:22 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:22 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:22 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:22 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:22 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:22 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:22 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:22 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:22 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:22 volumio volumio[1081]: info: No code Jul 05 11:05:22 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:22 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:22 volumio volumio[1081]: info: ------------------------------ 70ms Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:22 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:27 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:05:27 volumio volumio[1081]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::ClearQueue Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:27 volumio volumio[1081]: info: CorePlayQueue::clearPlayQueue Jul 05 11:05:27 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:05:27 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::addQueueItems Jul 05 11:05:27 volumio volumio[1081]: info: CorePlayQueue::addQueueItems Jul 05 11:05:27 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:05:27 volumio volumio[1081]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s284069&filter=s:g2804:country Jul 05 11:05:27 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 05 11:05:27 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:05:27 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::updateTrackBlock Jul 05 11:05:27 volumio volumio[1081]: info: CorePlayQueue::getTrackBlock Jul 05 11:05:27 volumio volumio[1081]: info: CoreCommandRouter::volumioPlay Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::play index 0 Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::play index undefined Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:27 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:27 volumio volumio[1081]: info: CoreStateMachine::startPlaybackTimer Jul 05 11:05:27 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:27 volumio volumio[1081]: info: [1751706327334] ControllerWebradio::clearAddPlayTrack Jul 05 11:05:27 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:05:27 volumio volumio[1081]: info: sendMpdCommand stop took 2 milliseconds Jul 05 11:05:27 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 11:05:27 volumio volumio[1081]: info: Jul 05 11:05:27 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:27 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:27 volumio volumio[1081]: info: sendMpdCommand clear took 1 milliseconds Jul 05 11:05:27 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand load "https://paranormalium.waw.pl/radio/8000/mp3_48" Jul 05 11:05:27 volumio volumio[1081]: info: Jul 05 11:05:27 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:27 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:27 volumio volumio[1081]: info: Jul 05 11:05:27 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:27 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:27 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:27 volumio volumio[1081]: info: ------------------------------ 5ms Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand add "https://paranormalium.waw.pl/radio/8000/mp3_48" Jul 05 11:05:28 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:28 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 666ms Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 665ms Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand add "https://paranormalium.waw.pl/radio/8000/mp3_48" took 1 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand play Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:28 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand play took 2 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:28 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:28 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 4ms Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 3ms Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 3ms Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand status took 17 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand status took 17 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand status took 17 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:28 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand status took 6 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand status took 3 milliseconds Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:28 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:28 volumio volumio[1081]: 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":"mp3_48","artist":null,"album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:28 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:28 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:28 volumio volumio[1081]: 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":"mp3_48","artist":null,"album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:28 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:28 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:28 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:28 volumio volumio[1081]: 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":"mp3_48","artist":null,"album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:28 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:28 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 43ms Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 48ms Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 48ms Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:28 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 29ms Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand status took 28 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 28 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 27 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 4ms Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand status took 3 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand status took 3 milliseconds Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:28 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:28 volumio volumio[1081]: 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":"The Monroe Institute Polska - Spotkanie online nr 48 (7 lis 2023) autodj","artist":"Radio Paranormalium","album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:28 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:28 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:28 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:28 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":883,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"The Monroe Institute Polska - Spotkanie online nr 48 (7 lis 2023) autodj","artist":"Radio Paranormalium","album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:28 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:28 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 50ms Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 46ms Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:28 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:28 volumio volumio[1081]: info: Jul 05 11:05:28 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 30 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 29 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 30 milliseconds Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 17ms Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand status took 16 milliseconds Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:28 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:28 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":883,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"The Monroe Institute Polska - Spotkanie online nr 48 (7 lis 2023) autodj","artist":"Radio Paranormalium","album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:28 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:28 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:28 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:28 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":883,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"The Monroe Institute Polska - Spotkanie online nr 48 (7 lis 2023) autodj","artist":"Radio Paranormalium","album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:28 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:28 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:28 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:28 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":883,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"The Monroe Institute Polska - Spotkanie online nr 48 (7 lis 2023) autodj","artist":"Radio Paranormalium","album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:28 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:28 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 83ms Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 57ms Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 56ms Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 40 milliseconds Jul 05 11:05:28 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:28 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:28 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:28 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":883,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"The Monroe Institute Polska - Spotkanie online nr 48 (7 lis 2023) autodj","artist":"Radio Paranormalium","album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:28 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:28 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:28 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:28 volumio volumio[1081]: info: ------------------------------ 72ms Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:28 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:30 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::ClearQueue Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::stPlaybackTimer Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::updateTrackBlock Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrackBlock Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::serviceStop Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::serviceStop Jul 05 11:05:30 volumio volumio[1081]: info: [1751706330647] ControllerWebradio::stop Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::clearPlayQueue Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::addQueueItems Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::addQueueItems Jul 05 11:05:30 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:05:30 volumio volumio[1081]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s105385&filter=s:g106:country Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:30 volumio volumio[1081]: info: Jul 05 11:05:30 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:30 volumio volumio[1081]: info: sendMpdCommand stop took 16 milliseconds Jul 05 11:05:30 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:30 volumio volumio[1081]: info: Jul 05 11:05:30 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:30 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:30 volumio volumio[1081]: info: Jul 05 11:05:30 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:30 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:30 volumio volumio[1081]: info: sendMpdCommand status took 2 milliseconds Jul 05 11:05:30 volumio volumio[1081]: info: sendMpdCommand status took 2 milliseconds Jul 05 11:05:30 volumio volumio[1081]: info: sendMpdCommand status took 2 milliseconds Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:30 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 05 11:05:30 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 05 11:05:30 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:30 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: 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":"The Monroe Institute Polska - Spotkanie online nr 48 (7 lis 2023) autodj","artist":"Radio Paranormalium","album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:30 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:30 volumio volumio[1081]: info: No code Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:30 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: 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":"The Monroe Institute Polska - Spotkanie online nr 48 (7 lis 2023) autodj","artist":"Radio Paranormalium","album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:30 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:30 volumio volumio[1081]: info: No code Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:30 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: 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":"The Monroe Institute Polska - Spotkanie online nr 48 (7 lis 2023) autodj","artist":"Radio Paranormalium","album":null,"uri":"https://paranormalium.waw.pl/radio/8000/mp3_48","trackType":""} Jul 05 11:05:30 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:30 volumio volumio[1081]: info: No code Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:30 volumio volumio[1081]: info: ------------------------------ 27ms Jul 05 11:05:30 volumio volumio[1081]: info: ------------------------------ 26ms Jul 05 11:05:30 volumio volumio[1081]: info: ------------------------------ 26ms Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:30 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::updateTrackBlock Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrackBlock Jul 05 11:05:30 volumio volumio[1081]: info: CoreCommandRouter::volumioPlay Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::play index 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::play index undefined Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: CoreStateMachine::startPlaybackTimer Jul 05 11:05:30 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:30 volumio volumio[1081]: info: [1751706330860] ControllerWebradio::clearAddPlayTrack Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:05:30 volumio volumio[1081]: info: sendMpdCommand stop took 2 milliseconds Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 11:05:30 volumio volumio[1081]: info: Jul 05 11:05:30 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:30 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:30 volumio volumio[1081]: info: sendMpdCommand clear took 1 milliseconds Jul 05 11:05:30 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radiobaobab.pl:8000/radiobaobab.mp3" Jul 05 11:05:30 volumio volumio[1081]: info: Jul 05 11:05:30 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:30 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:30 volumio volumio[1081]: info: Jul 05 11:05:30 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:30 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:30 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:30 volumio volumio[1081]: info: ------------------------------ 4ms Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radiobaobab.pl:8000/radiobaobab.mp3" Jul 05 11:05:31 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:31 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:31 volumio volumio[1081]: info: ------------------------------ 242ms Jul 05 11:05:31 volumio volumio[1081]: info: ------------------------------ 241ms Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand add "http://stream.radiobaobab.pl:8000/radiobaobab.mp3" took 1 milliseconds Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand play Jul 05 11:05:31 volumio volumio[1081]: info: Jul 05 11:05:31 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:31 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:31 volumio volumio[1081]: info: Jul 05 11:05:31 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:31 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:31 volumio volumio[1081]: info: Jul 05 11:05:31 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:31 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand play took 3 milliseconds Jul 05 11:05:31 volumio volumio[1081]: info: ------------------------------ 3ms Jul 05 11:05:31 volumio volumio[1081]: info: ------------------------------ 2ms Jul 05 11:05:31 volumio volumio[1081]: info: ------------------------------ 1ms Jul 05 11:05:31 volumio volumio[1081]: info: Jul 05 11:05:31 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:31 volumio volumio[1081]: info: Jul 05 11:05:31 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:31 volumio volumio[1081]: info: Jul 05 11:05:31 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand status took 15 milliseconds Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:31 volumio volumio[1081]: info: Jul 05 11:05:31 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:31 volumio volumio[1081]: info: Jul 05 11:05:31 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand status took 17 milliseconds Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand status took 16 milliseconds Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand status took 2 milliseconds Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:31 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:31 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radiobaobab.mp3","artist":null,"album":null,"uri":"http://stream.radiobaobab.pl:8000/radiobaobab.mp3","trackType":"mp3"} Jul 05 11:05:31 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:31 volumio volumio[1081]: info: ------------------------------ 22ms Jul 05 11:05:31 volumio volumio[1081]: info: Jul 05 11:05:31 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand status took 2 milliseconds Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:31 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:31 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radiobaobab.mp3","artist":null,"album":null,"uri":"http://stream.radiobaobab.pl:8000/radiobaobab.mp3","trackType":"mp3"} Jul 05 11:05:31 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:31 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:31 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:31 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radiobaobab.mp3","artist":null,"album":null,"uri":"http://stream.radiobaobab.pl:8000/radiobaobab.mp3","trackType":"mp3"} Jul 05 11:05:31 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:31 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:31 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:31 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radiobaobab.mp3","artist":null,"album":null,"uri":"http://stream.radiobaobab.pl:8000/radiobaobab.mp3","trackType":"mp3"} Jul 05 11:05:31 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:31 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:31 volumio volumio[1081]: info: ------------------------------ 39ms Jul 05 11:05:31 volumio volumio[1081]: info: ------------------------------ 39ms Jul 05 11:05:31 volumio volumio[1081]: info: ------------------------------ 25ms Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 19 milliseconds Jul 05 11:05:31 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 19 milliseconds Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:31 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:31 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:31 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radiobaobab.mp3","artist":null,"album":null,"uri":"http://stream.radiobaobab.pl:8000/radiobaobab.mp3","trackType":"mp3"} Jul 05 11:05:31 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:31 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:31 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:31 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:31 volumio volumio[1081]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radiobaobab.mp3","artist":null,"album":null,"uri":"http://stream.radiobaobab.pl:8000/radiobaobab.mp3","trackType":"mp3"} Jul 05 11:05:31 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState stateService play Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:05:31 volumio volumio[1081]: info: Received an update from plugin. extracting info from payload Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:31 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:31 volumio volumio[1081]: info: ------------------------------ 43ms Jul 05 11:05:31 volumio volumio[1081]: info: ------------------------------ 39ms Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:31 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::ClearQueue Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::stPlaybackTimer Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::updateTrackBlock Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrackBlock Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::serviceStop Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::serviceStop Jul 05 11:05:36 volumio volumio[1081]: info: [1751706336568] ControllerWebradio::stop Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::clearPlayQueue Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::addQueueItems Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::addQueueItems Jul 05 11:05:36 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:05:36 volumio volumio[1081]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s237255&filter=s:g54:country Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::updateTrackBlock Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrackBlock Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPlay Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::play index 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::play index undefined Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::startPlaybackTimer Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: info: [1751706336581] ControllerWebradio::clearAddPlayTrack Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand stop took 18 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand stop took 4 milliseconds Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:36 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand clear took 3 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand status took 3 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand status took 2 milliseconds Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand load "http://mp3.polskieradio.pl:8060" Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 12ms Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 11ms Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:36 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:36 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:36 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 13ms Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 11 milliseconds Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:36 volumio volumio[1081]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 17ms Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand add "http://mp3.polskieradio.pl:8060" Jul 05 11:05:36 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:36 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:36 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 196ms Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 195ms Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand add "http://mp3.polskieradio.pl:8060" took 1 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand play Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:36 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:36 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 5ms Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand play took 4 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 3ms Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 2ms Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:36 volumio volumio[1081]: info: Jul 05 11:05:36 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand status took 8 milliseconds Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand status took 8 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand clearerror took 6 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand status took 6 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: 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":"mp3.polskieradio.pl:8060","artist":null,"album":null,"uri":"http://mp3.polskieradio.pl:8060","trackType":"pl:8060"} Jul 05 11:05:36 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: No code Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 23ms Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand status took 23 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand clearerror took 22 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand clearerror took 21 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 19 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 19 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: 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":"mp3.polskieradio.pl:8060","artist":null,"album":null,"uri":"http://mp3.polskieradio.pl:8060","trackType":"pl:8060"} Jul 05 11:05:36 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: No code Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: 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":"mp3.polskieradio.pl:8060","artist":null,"album":null,"uri":"http://mp3.polskieradio.pl:8060","trackType":"pl:8060"} Jul 05 11:05:36 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: No code Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: 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":"mp3.polskieradio.pl:8060","artist":null,"album":null,"uri":"http://mp3.polskieradio.pl:8060","trackType":"pl:8060"} Jul 05 11:05:36 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: No code Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: 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":"mp3.polskieradio.pl:8060","artist":null,"album":null,"uri":"http://mp3.polskieradio.pl:8060","trackType":"pl:8060"} Jul 05 11:05:36 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: No code Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 56ms Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 56ms Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 57ms Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 53ms Jul 05 11:05:36 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 29 milliseconds Jul 05 11:05:36 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:36 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:36 volumio volumio[1081]: 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":"mp3.polskieradio.pl:8060","artist":null,"album":null,"uri":"http://mp3.polskieradio.pl:8060","trackType":"pl:8060"} Jul 05 11:05:36 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: No code Jul 05 11:05:36 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:36 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:36 volumio volumio[1081]: info: ------------------------------ 62ms Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:36 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:38 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:05:38 volumio volumio[1081]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::ClearQueue Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:38 volumio volumio[1081]: info: CorePlayQueue::clearPlayQueue Jul 05 11:05:38 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:05:38 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::addQueueItems Jul 05 11:05:38 volumio volumio[1081]: info: CorePlayQueue::addQueueItems Jul 05 11:05:38 volumio volumio[1081]: info: Preload queue cleared Jul 05 11:05:38 volumio volumio[1081]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s104484&filter=s:g11:country Jul 05 11:05:38 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 05 11:05:38 volumio volumio[1081]: info: CoreCommandRouter::volumioPushQueue Jul 05 11:05:38 volumio volumio[1081]: info: CorePlayQueue::saveQueue Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::updateTrackBlock Jul 05 11:05:38 volumio volumio[1081]: info: CorePlayQueue::getTrackBlock Jul 05 11:05:38 volumio volumio[1081]: info: CoreCommandRouter::volumioPlay Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::play index 0 Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::stop Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::play index undefined Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:05:38 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:38 volumio volumio[1081]: info: CoreStateMachine::startPlaybackTimer Jul 05 11:05:38 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:38 volumio volumio[1081]: info: [1751706338482] ControllerWebradio::clearAddPlayTrack Jul 05 11:05:38 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:05:38 volumio volumio[1081]: info: sendMpdCommand stop took 2 milliseconds Jul 05 11:05:38 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 11:05:38 volumio volumio[1081]: info: Jul 05 11:05:38 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:38 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:38 volumio volumio[1081]: info: sendMpdCommand clear took 1 milliseconds Jul 05 11:05:38 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand load "https://radiojazz.out.airtime.pro/radiojazz_a" Jul 05 11:05:38 volumio volumio[1081]: info: Jul 05 11:05:38 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:38 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:38 volumio volumio[1081]: info: Jul 05 11:05:38 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:38 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:38 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:38 volumio volumio[1081]: info: ------------------------------ 3ms Jul 05 11:05:39 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand add "https://radiojazz.out.airtime.pro/radiojazz_a" Jul 05 11:05:39 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:39 volumio volumio[1081]: error: updateQueue error: null Jul 05 11:05:39 volumio volumio[1081]: info: ------------------------------ 1164ms Jul 05 11:05:39 volumio volumio[1081]: info: ------------------------------ 1163ms Jul 05 11:05:39 volumio volumio[1081]: info: sendMpdCommand add "https://radiojazz.out.airtime.pro/radiojazz_a" took 1 milliseconds Jul 05 11:05:39 volumio volumio[1081]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 05 11:05:39 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand play Jul 05 11:05:39 volumio volumio[1081]: info: Jul 05 11:05:39 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:39 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:39 volumio volumio[1081]: info: Jul 05 11:05:39 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:39 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:39 volumio volumio[1081]: info: Jul 05 11:05:39 volumio volumio[1081]: ---------------------------- MPD announces system playlist update Jul 05 11:05:39 volumio volumio[1081]: info: Ignoring MPD Status Update Jul 05 11:05:39 volumio volumio[1081]: info: sendMpdCommand play took 4 milliseconds Jul 05 11:05:39 volumio volumio[1081]: info: ------------------------------ 4ms Jul 05 11:05:39 volumio volumio[1081]: info: ------------------------------ 3ms Jul 05 11:05:39 volumio volumio[1081]: info: ------------------------------ 2ms Jul 05 11:05:40 volumio volumio[1081]: info: Jul 05 11:05:40 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:40 volumio volumio[1081]: info: Jul 05 11:05:40 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:40 volumio volumio[1081]: info: Jul 05 11:05:40 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:40 volumio volumio[1081]: info: Jul 05 11:05:40 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:40 volumio volumio[1081]: info: Jul 05 11:05:40 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:40 volumio volumio[1081]: info: Jul 05 11:05:40 volumio volumio[1081]: ---------------------------- MPD announces state update: player Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::getState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand status took 8 milliseconds Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand status took 7 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand clearerror took 6 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand status took 6 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseState Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:40 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:40 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: No code Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: ------------------------------ 22ms Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand clearerror took 18 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand clearerror took 19 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 05 11:05:40 volumio volumio[1081]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:40 volumio volumio[1081]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:40 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:40 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: No code Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:40 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:40 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: No code Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:40 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:40 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: No code Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:40 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:40 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: No code Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: ControllerMpd::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::servicePushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: CorePlayQueue::getTrack 0 Jul 05 11:05:40 volumio volumio[1081]: 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":"radiojazz_a","artist":null,"album":null,"uri":"https://radiojazz.out.airtime.pro/radiojazz_a","trackType":""} Jul 05 11:05:40 volumio volumio[1081]: verbose: CURRENT POSITION 0 Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState stateService stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: No code Jul 05 11:05:40 volumio volumio[1081]: info: CoreStateMachine::pushState Jul 05 11:05:40 volumio volumio[1081]: info: CoreCommandRouter::volumioPushState Jul 05 11:05:40 volumio volumio[1081]: info: ------------------------------ 57ms Jul 05 11:05:40 volumio volumio[1081]: info: ------------------------------ 57ms Jul 05 11:05:40 volumio volumio[1081]: info: ------------------------------ 56ms Jul 05 11:05:40 volumio volumio[1081]: info: ------------------------------ 54ms Jul 05 11:05:40 volumio volumio[1081]: info: ------------------------------ 54ms Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: SPOTIFY VOLUME 58 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: VOLUMIO VOLUME 59 Jul 05 11:05:40 volumio volumio[1081]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 05 11:05:50 volumio volumio[1081]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 05 11:05:50 volumio volumio[1081]: info: READ Jul 05 11:05:51 volumio volumio[1081]: Use XMLElement.setAttribute instead Jul 05 11:05:51 volumio volumio[1081]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 11:05:51 volumio volumio[1081]: TypeError: children[i].attr(...).value is not a function Jul 05 11:05:51 volumio volumio[1081]: at /volumio/app/plugins/music_service/webradio/index.js:286:47 Jul 05 11:05:51 volumio volumio[1081]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jul 05 11:05:51 volumio volumio[1081]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 11:05:51 volumio sudo[10094]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-07-05 11:04' Jul 05 11:05:51 volumio sudo[10094]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f224c96f24bffeaafa716653a140d091b9b76522" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon May 19 11:28:05 UTC 2025" VOLUMIO_VERSION="0.067" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="178d9db9b0f50342f3fdf788565b826d"