-- Logs begin at Sun 2024-03-31 12:45:12 UTC, end at Sun 2024-03-31 13:37:04 UTC. -- Mar 31 13:36:01 volumio volumio[8484]: info: Mar 31 13:36:01 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:01 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:01 volumio volumio[8484]: info: Mar 31 13:36:01 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:01 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:01 volumio volumio[8484]: info: Mar 31 13:36:01 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:01 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 31 13:36:01 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 31 13:36:01 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 31 13:36:01 volumio volumio[8484]: info: sendMpdCommand status took 3 milliseconds Mar 31 13:36:01 volumio volumio[8484]: info: sendMpdCommand clearerror took 2 milliseconds Mar 31 13:36:01 volumio volumio[8484]: info: sendMpdCommand clearerror took 2 milliseconds Mar 31 13:36:01 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:01 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:01 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:01 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:01 volumio volumio[8484]: 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":"IRO","artist":"(#1 - 28/500) FM Gold","album":null,"uri":"https://stream.radiofmgold.be:3181/IRO","trackType":""} Mar 31 13:36:01 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::syncState stateService stop Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:01 volumio volumio[8484]: info: No code Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:01 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:01 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:01 volumio volumio[8484]: 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":"IRO","artist":"(#1 - 28/500) FM Gold","album":null,"uri":"https://stream.radiofmgold.be:3181/IRO","trackType":""} Mar 31 13:36:01 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::syncState stateService stop Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:01 volumio volumio[8484]: info: No code Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:01 volumio volumio[8484]: info: ------------------------------ 14ms Mar 31 13:36:01 volumio volumio[8484]: info: ------------------------------ 13ms Mar 31 13:36:01 volumio volumio[8484]: info: sendMpdCommand clearerror took 13 milliseconds Mar 31 13:36:01 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 12 milliseconds Mar 31 13:36:01 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:01 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:01 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:01 volumio volumio[8484]: 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":"IRO","artist":"(#1 - 28/500) FM Gold","album":null,"uri":"https://stream.radiofmgold.be:3181/IRO","trackType":""} Mar 31 13:36:01 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::syncState stateService stop Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:01 volumio volumio[8484]: info: No code Mar 31 13:36:01 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:01 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:01 volumio volumio[8484]: info: ------------------------------ 21ms Mar 31 13:36:02 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:02 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Transmitter ID) Mar 31 13:36:02 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00001081/00006000 Mar 31 13:36:02 volumio kernel: ath10k_pci 0000:3a:00.0: [ 0] RxErr (First) Mar 31 13:36:02 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:02 volumio kernel: ath10k_pci 0000:3a:00.0: [12] Timeout Mar 31 13:36:03 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:03 volumio volumio[8484]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::ClearQueue Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:03 volumio volumio[8484]: info: CorePlayQueue::clearPlayQueue Mar 31 13:36:03 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:03 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::addQueueItems Mar 31 13:36:03 volumio volumio[8484]: info: CorePlayQueue::addQueueItems Mar 31 13:36:03 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:03 volumio volumio[8484]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1823426 Mar 31 13:36:03 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 31 13:36:03 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:03 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::updateTrackBlock Mar 31 13:36:03 volumio volumio[8484]: info: CorePlayQueue::getTrackBlock Mar 31 13:36:03 volumio volumio[8484]: info: CoreCommandRouter::volumioPlay Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::play index 0 Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::play index undefined Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:03 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::startPlaybackTimer Mar 31 13:36:03 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:03 volumio volumio[8484]: info: [1711892163457] ControllerWebradio::clearAddPlayTrack Mar 31 13:36:03 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 13:36:03 volumio volumio[8484]: info: sendMpdCommand stop took 0 milliseconds Mar 31 13:36:03 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clear Mar 31 13:36:03 volumio volumio[8484]: info: Mar 31 13:36:03 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:03 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:03 volumio volumio[8484]: info: sendMpdCommand clear took 1 milliseconds Mar 31 13:36:03 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1823426" Mar 31 13:36:03 volumio volumio[8484]: error: updateQueue error: null Mar 31 13:36:03 volumio volumio[8484]: info: ------------------------------ 0ms Mar 31 13:36:03 volumio volumio[8484]: info: Mar 31 13:36:03 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:03 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:03 volumio volumio[8484]: info: Mar 31 13:36:03 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:03 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:03 volumio volumio[8484]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1823426" took 314 milliseconds Mar 31 13:36:03 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 31 13:36:03 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand play Mar 31 13:36:03 volumio volumio[8484]: info: Mar 31 13:36:03 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:03 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:03 volumio volumio[8484]: info: ------------------------------ 316ms Mar 31 13:36:03 volumio volumio[8484]: info: ------------------------------ 316ms Mar 31 13:36:03 volumio volumio[8484]: info: Mar 31 13:36:03 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:03 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:03 volumio volumio[8484]: info: Mar 31 13:36:03 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:03 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:03 volumio volumio[8484]: info: sendMpdCommand play took 2 milliseconds Mar 31 13:36:03 volumio volumio[8484]: info: ------------------------------ 2ms Mar 31 13:36:03 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 2 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: 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":"spa_mobile_aac","artist":"1.FM - Destination: SPA (www.1.fm)","album":null,"uri":"http://185.33.21.111:80/spa_mobile_aac","trackType":""} Mar 31 13:36:05 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 4ms Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 2 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 0 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 0 milliseconds Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: 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":"spa_mobile_aac","artist":"1.FM - Destination: SPA (www.1.fm)","album":null,"uri":"http://185.33.21.111:80/spa_mobile_aac","trackType":""} Mar 31 13:36:05 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:05 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: 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":"spa_mobile_aac","artist":"1.FM - Destination: SPA (www.1.fm)","album":null,"uri":"http://185.33.21.111:80/spa_mobile_aac","trackType":""} Mar 31 13:36:05 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:05 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 12ms Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 11ms Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: 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":"spa_mobile_aac","artist":"1.FM - Destination: SPA (www.1.fm)","album":null,"uri":"http://185.33.21.111:80/spa_mobile_aac","trackType":""} Mar 31 13:36:05 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:05 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: 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":"spa_mobile_aac","artist":"1.FM - Destination: SPA (www.1.fm)","album":null,"uri":"http://185.33.21.111:80/spa_mobile_aac","trackType":""} Mar 31 13:36:05 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:05 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: 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":"spa_mobile_aac","artist":"1.FM - Destination: SPA (www.1.fm)","album":null,"uri":"http://185.33.21.111:80/spa_mobile_aac","trackType":""} Mar 31 13:36:05 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:05 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 22ms Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 20ms Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 20ms Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:05 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:05 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 0 milliseconds Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:05 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 2ms Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 2 milliseconds Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Dan Gibson - Tread Lightly","artist":"spa","album":null,"uri":"http://185.33.21.111:80/spa_mobile_aac","trackType":""} Mar 31 13:36:05 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:05 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Dan Gibson - Tread Lightly","artist":"spa","album":null,"uri":"http://185.33.21.111:80/spa_mobile_aac","trackType":""} Mar 31 13:36:05 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:05 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 11ms Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 11ms Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Dan Gibson - Tread Lightly","artist":"spa","album":null,"uri":"http://185.33.21.111:80/spa_mobile_aac","trackType":""} Mar 31 13:36:05 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:05 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 15ms Mar 31 13:36:05 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::ClearQueue Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::stPlaybackTimer Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::updateTrackBlock Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrackBlock Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::serviceStop Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::serviceStop Mar 31 13:36:05 volumio volumio[8484]: info: [1711892165668] ControllerWebradio::stop Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::clearPlayQueue Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::addQueueItems Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::addQueueItems Mar 31 13:36:05 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:05 volumio volumio[8484]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=181568 Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::updateTrackBlock Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrackBlock Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPlay Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::play index 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::play index undefined Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::startPlaybackTimer Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: [1711892165672] ControllerWebradio::clearAddPlayTrack Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand stop took 4 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand stop took 1 milliseconds Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clear Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:05 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 2 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand clear took 1 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=181568" Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 31 13:36:05 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:05 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:05 volumio volumio[8484]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 6ms Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 6ms Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:05 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:05 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:05 volumio volumio[8484]: error: updateQueue error: null Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 6ms Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:05 volumio volumio[8484]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 8ms Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=181568" took 321 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 31 13:36:05 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand play Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:05 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 316ms Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 316ms Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:05 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:05 volumio volumio[8484]: info: Mar 31 13:36:05 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:05 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:05 volumio volumio[8484]: info: sendMpdCommand play took 1 milliseconds Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:05 volumio volumio[8484]: info: ------------------------------ 0ms Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand status took 0 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: 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":"vhiveradiostream","artist":"(#1 - 68/999) A - V-Hive Radio Philippines - The hottest pop Pinoy, OPM, Tagalog radio station.","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: 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":"vhiveradiostream","artist":"(#1 - 68/999) A - V-Hive Radio Philippines - The hottest pop Pinoy, OPM, Tagalog radio station.","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:06 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: 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":"vhiveradiostream","artist":"(#1 - 68/999) A - V-Hive Radio Philippines - The hottest pop Pinoy, OPM, Tagalog radio station.","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:06 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 5ms Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 9ms Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 8ms Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand status took 0 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand status took 0 milliseconds Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: 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":"vhiveradiostream","artist":"(#1 - 68/999) A - V-Hive Radio Philippines - The hottest pop Pinoy, OPM, Tagalog radio station.","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:06 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 16ms Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: 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":"vhiveradiostream","artist":"(#1 - 68/999) A - V-Hive Radio Philippines - The hottest pop Pinoy, OPM, Tagalog radio station.","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:06 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: 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":"vhiveradiostream","artist":"(#1 - 68/999) A - V-Hive Radio Philippines - The hottest pop Pinoy, OPM, Tagalog radio station.","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:06 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 17ms Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 17ms Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:06 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:06 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:06 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:06 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:06 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"PAIN IN MY HEART - zoo w/ lyrics","artist":"AAA-V-Hive Radio Philippines","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:06 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"PAIN IN MY HEART - zoo w/ lyrics","artist":"AAA-V-Hive Radio Philippines","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:06 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 10ms Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 10ms Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:06 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:06 volumio volumio[8484]: info: Mar 31 13:36:06 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 0ms Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"PAIN IN MY HEART - zoo w/ lyrics","artist":"AAA-V-Hive Radio Philippines","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:06 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"PAIN IN MY HEART - zoo w/ lyrics","artist":"AAA-V-Hive Radio Philippines","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:06 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"PAIN IN MY HEART - zoo w/ lyrics","artist":"AAA-V-Hive Radio Philippines","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:06 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 24ms Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 24ms Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 23ms Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand status took 22 milliseconds Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:06 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:06 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:06 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:06 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:06 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"PAIN IN MY HEART - zoo w/ lyrics","artist":"AAA-V-Hive Radio Philippines","album":null,"uri":"http://192.99.8.192:3154/vhiveradiostream","trackType":""} Mar 31 13:36:06 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:06 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:06 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:06 volumio volumio[8484]: info: ------------------------------ 27ms Mar 31 13:36:07 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:07 volumio kernel: pcieport 0000:00:1c.4: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Transmitter ID) Mar 31 13:36:07 volumio kernel: pcieport 0000:00:1c.4: device [8086:9d14] error status/mask=00001000/00002000 Mar 31 13:36:07 volumio kernel: pcieport 0000:00:1c.4: [12] Timeout Mar 31 13:36:07 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) Mar 31 13:36:07 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=000000c1/00006000 Mar 31 13:36:07 volumio kernel: ath10k_pci 0000:3a:00.0: [ 0] RxErr (First) Mar 31 13:36:07 volumio kernel: ath10k_pci 0000:3a:00.0: [ 6] BadTLP Mar 31 13:36:07 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:07 volumio kernel: ath10k_pci 0000:3a:00.0: AER: Error of this Agent is reported first Mar 31 13:36:07 volumio kernel: pcieport 0000:00:1c.4: AER: Corrected error received: 0000:00:1c.4 Mar 31 13:36:07 volumio kernel: pcieport 0000:00:1c.4: AER: can't find device of ID00e4 Mar 31 13:36:07 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:07 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Receiver ID) Mar 31 13:36:07 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00000080/00006000 Mar 31 13:36:07 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:08 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:08 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Receiver ID) Mar 31 13:36:08 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00000080/00006000 Mar 31 13:36:08 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:08 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:08 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Transmitter ID) Mar 31 13:36:08 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00001081/00006000 Mar 31 13:36:08 volumio kernel: ath10k_pci 0000:3a:00.0: [ 0] RxErr (First) Mar 31 13:36:08 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:08 volumio kernel: ath10k_pci 0000:3a:00.0: [12] Timeout Mar 31 13:36:10 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:10 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Receiver ID) Mar 31 13:36:10 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00000080/00006000 Mar 31 13:36:10 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:13 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::ClearQueue Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::stPlaybackTimer Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::updateTrackBlock Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::getTrackBlock Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::serviceStop Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::serviceStop Mar 31 13:36:13 volumio volumio[8484]: info: [1711892173919] ControllerWebradio::stop Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::clearPlayQueue Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::addQueueItems Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::addQueueItems Mar 31 13:36:13 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:13 volumio volumio[8484]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99291192 Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::updateTrackBlock Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::getTrackBlock Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::volumioPlay Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::play index 0 Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::play index undefined Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::startPlaybackTimer Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:13 volumio volumio[8484]: info: [1711892173922] ControllerWebradio::clearAddPlayTrack Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 13:36:13 volumio volumio[8484]: info: Mar 31 13:36:13 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:13 volumio volumio[8484]: info: sendMpdCommand stop took 5 milliseconds Mar 31 13:36:13 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:13 volumio volumio[8484]: info: sendMpdCommand stop took 1 milliseconds Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clear Mar 31 13:36:13 volumio volumio[8484]: info: Mar 31 13:36:13 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:13 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:13 volumio volumio[8484]: info: Mar 31 13:36:13 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:13 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:13 volumio volumio[8484]: info: Mar 31 13:36:13 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:13 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:13 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:13 volumio volumio[8484]: info: sendMpdCommand clear took 1 milliseconds Mar 31 13:36:13 volumio volumio[8484]: info: sendMpdCommand status took 0 milliseconds Mar 31 13:36:13 volumio volumio[8484]: info: sendMpdCommand status took 0 milliseconds Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99291192" Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:13 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:13 volumio volumio[8484]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 31 13:36:13 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:13 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:13 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:13 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:13 volumio volumio[8484]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 31 13:36:13 volumio volumio[8484]: info: ------------------------------ 5ms Mar 31 13:36:13 volumio volumio[8484]: info: ------------------------------ 5ms Mar 31 13:36:13 volumio volumio[8484]: info: Mar 31 13:36:13 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:13 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:13 volumio volumio[8484]: info: Mar 31 13:36:13 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:13 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:13 volumio volumio[8484]: error: updateQueue error: null Mar 31 13:36:13 volumio volumio[8484]: info: ------------------------------ 6ms Mar 31 13:36:13 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 31 13:36:13 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:13 volumio volumio[8484]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 31 13:36:13 volumio volumio[8484]: info: ------------------------------ 7ms Mar 31 13:36:14 volumio volumio[8484]: info: Mar 31 13:36:14 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:14 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:14 volumio volumio[8484]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99291192" took 808 milliseconds Mar 31 13:36:14 volumio volumio[8484]: info: ------------------------------ 803ms Mar 31 13:36:14 volumio volumio[8484]: info: ------------------------------ 804ms Mar 31 13:36:14 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 31 13:36:14 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand play Mar 31 13:36:14 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:14 volumio volumio[8484]: info: Mar 31 13:36:14 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:14 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:14 volumio volumio[8484]: info: Mar 31 13:36:14 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:14 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:14 volumio volumio[8484]: info: sendMpdCommand play took 0 milliseconds Mar 31 13:36:14 volumio volumio[8484]: info: ------------------------------ 0ms Mar 31 13:36:15 volumio volumio[8484]: info: Mar 31 13:36:15 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:15 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:15 volumio volumio[8484]: info: Mar 31 13:36:15 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:15 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 31 13:36:15 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:15 volumio volumio[8484]: info: Mar 31 13:36:15 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:15 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 31 13:36:15 volumio volumio[8484]: info: sendMpdCommand status took 2 milliseconds Mar 31 13:36:15 volumio volumio[8484]: info: sendMpdCommand clearerror took 1 milliseconds Mar 31 13:36:15 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:15 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:15 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:15 volumio volumio[8484]: 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":"housemusicradiouk","artist":"House Music Radio uk","album":null,"uri":"http://listen.shoutcast.com/housemusicradiouk","trackType":""} Mar 31 13:36:15 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::syncState stateService stop Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:15 volumio volumio[8484]: info: No code Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:15 volumio volumio[8484]: info: ------------------------------ 8ms Mar 31 13:36:15 volumio volumio[8484]: info: sendMpdCommand status took 8 milliseconds Mar 31 13:36:15 volumio volumio[8484]: info: sendMpdCommand clearerror took 7 milliseconds Mar 31 13:36:15 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:15 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:15 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:15 volumio volumio[8484]: 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":"housemusicradiouk","artist":"House Music Radio uk","album":null,"uri":"http://listen.shoutcast.com/housemusicradiouk","trackType":""} Mar 31 13:36:15 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::syncState stateService stop Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:15 volumio volumio[8484]: info: No code Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:15 volumio volumio[8484]: info: ------------------------------ 13ms Mar 31 13:36:15 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 31 13:36:15 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:15 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:15 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:15 volumio volumio[8484]: 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":"housemusicradiouk","artist":"House Music Radio uk","album":null,"uri":"http://listen.shoutcast.com/housemusicradiouk","trackType":""} Mar 31 13:36:15 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::syncState stateService stop Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:15 volumio volumio[8484]: info: No code Mar 31 13:36:15 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:15 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:15 volumio volumio[8484]: info: ------------------------------ 16ms Mar 31 13:36:21 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:21 volumio volumio[8484]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::ClearQueue Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:21 volumio volumio[8484]: info: CorePlayQueue::clearPlayQueue Mar 31 13:36:21 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:21 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::addQueueItems Mar 31 13:36:21 volumio volumio[8484]: info: CorePlayQueue::addQueueItems Mar 31 13:36:21 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:21 volumio volumio[8484]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=167090 Mar 31 13:36:21 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 31 13:36:21 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:21 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::updateTrackBlock Mar 31 13:36:21 volumio volumio[8484]: info: CorePlayQueue::getTrackBlock Mar 31 13:36:21 volumio volumio[8484]: info: CoreCommandRouter::volumioPlay Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::play index 0 Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::play index undefined Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:21 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::startPlaybackTimer Mar 31 13:36:21 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:21 volumio volumio[8484]: info: [1711892181554] ControllerWebradio::clearAddPlayTrack Mar 31 13:36:21 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 13:36:21 volumio volumio[8484]: info: sendMpdCommand stop took 1 milliseconds Mar 31 13:36:21 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clear Mar 31 13:36:21 volumio volumio[8484]: info: Mar 31 13:36:21 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:21 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:21 volumio volumio[8484]: info: sendMpdCommand clear took 0 milliseconds Mar 31 13:36:21 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=167090" Mar 31 13:36:21 volumio volumio[8484]: info: Mar 31 13:36:21 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:21 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:21 volumio volumio[8484]: info: Mar 31 13:36:21 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:21 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:21 volumio volumio[8484]: error: updateQueue error: null Mar 31 13:36:21 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:21 volumio volumio[8484]: info: Mar 31 13:36:21 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:21 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:21 volumio volumio[8484]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=167090" took 294 milliseconds Mar 31 13:36:21 volumio volumio[8484]: info: ------------------------------ 294ms Mar 31 13:36:21 volumio volumio[8484]: info: ------------------------------ 293ms Mar 31 13:36:21 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 31 13:36:21 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand play Mar 31 13:36:21 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:21 volumio volumio[8484]: info: Mar 31 13:36:21 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:21 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:21 volumio volumio[8484]: info: Mar 31 13:36:21 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:21 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:21 volumio volumio[8484]: info: sendMpdCommand play took 1 milliseconds Mar 31 13:36:21 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:21 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:25 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::ClearQueue Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:25 volumio volumio[8484]: info: CorePlayQueue::clearPlayQueue Mar 31 13:36:25 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::addQueueItems Mar 31 13:36:25 volumio volumio[8484]: info: CorePlayQueue::addQueueItems Mar 31 13:36:25 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:25 volumio volumio[8484]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99536661 Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:25 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::updateTrackBlock Mar 31 13:36:25 volumio volumio[8484]: info: CorePlayQueue::getTrackBlock Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::volumioPlay Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::play index 0 Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::play index undefined Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:25 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::startPlaybackTimer Mar 31 13:36:25 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:25 volumio volumio[8484]: info: [1711892185101] ControllerWebradio::clearAddPlayTrack Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 13:36:25 volumio volumio[8484]: info: Mar 31 13:36:25 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:25 volumio volumio[8484]: info: sendMpdCommand stop took 1 milliseconds Mar 31 13:36:25 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clear Mar 31 13:36:25 volumio volumio[8484]: info: Mar 31 13:36:25 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:25 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:25 volumio volumio[8484]: info: sendMpdCommand status took 0 milliseconds Mar 31 13:36:25 volumio volumio[8484]: info: sendMpdCommand clear took 0 milliseconds Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99536661" Mar 31 13:36:25 volumio volumio[8484]: info: Mar 31 13:36:25 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:25 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:25 volumio volumio[8484]: info: Mar 31 13:36:25 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:25 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:25 volumio volumio[8484]: error: updateQueue error: null Mar 31 13:36:25 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:25 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:25 volumio volumio[8484]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 31 13:36:25 volumio volumio[8484]: info: ------------------------------ 2ms Mar 31 13:36:25 volumio volumio[8484]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99536661" took 310 milliseconds Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand play Mar 31 13:36:25 volumio volumio[8484]: info: Mar 31 13:36:25 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:25 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:25 volumio volumio[8484]: info: sendMpdCommand status took 311 milliseconds Mar 31 13:36:25 volumio volumio[8484]: info: sendMpdCommand status took 310 milliseconds Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:25 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:25 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:25 volumio volumio[8484]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 31 13:36:25 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::syncState stateService stop Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:25 volumio volumio[8484]: info: No code Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:25 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:25 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:25 volumio volumio[8484]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 31 13:36:25 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::syncState stateService stop Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:25 volumio volumio[8484]: info: No code Mar 31 13:36:25 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:25 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:25 volumio volumio[8484]: info: ------------------------------ 322ms Mar 31 13:36:25 volumio volumio[8484]: info: ------------------------------ 322ms Mar 31 13:36:25 volumio volumio[8484]: info: Mar 31 13:36:25 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:25 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:25 volumio volumio[8484]: info: Mar 31 13:36:25 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:25 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:25 volumio volumio[8484]: info: sendMpdCommand play took 13 milliseconds Mar 31 13:36:25 volumio volumio[8484]: info: ------------------------------ 13ms Mar 31 13:36:25 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:25 volumio volumio[8484]: info: ------------------------------ 0ms Mar 31 13:36:25 volumio kernel: pcieport 0000:00:1c.4: AER: Corrected error received: 0000:3a:00.0 Mar 31 13:36:25 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) Mar 31 13:36:25 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00000001/00006000 Mar 31 13:36:25 volumio kernel: ath10k_pci 0000:3a:00.0: [ 0] RxErr (First) Mar 31 13:36:25 volumio volumio[8484]: info: Mar 31 13:36:25 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:25 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:25 volumio volumio[8484]: info: Mar 31 13:36:25 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:25 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 31 13:36:25 volumio volumio[8484]: info: sendMpdCommand status took 2 milliseconds Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:25 volumio volumio[8484]: info: Mar 31 13:36:25 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:25 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:25 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:26 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 31 13:36:26 volumio volumio[8484]: info: sendMpdCommand status took 4 milliseconds Mar 31 13:36:26 volumio volumio[8484]: info: sendMpdCommand clearerror took 3 milliseconds Mar 31 13:36:26 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 31 13:36:26 volumio volumio[8484]: info: sendMpdCommand status took 2 milliseconds Mar 31 13:36:26 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:26 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:26 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:26 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:26 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:26 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:26 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:26 volumio volumio[8484]: 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":"stream","artist":"(#1 - 71/2000) Radio SRS Suriname","album":null,"uri":"https://38.242.219.45:8060/stream","trackType":""} Mar 31 13:36:26 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::syncState stateService stop Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:26 volumio volumio[8484]: info: No code Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:26 volumio volumio[8484]: info: ------------------------------ 12ms Mar 31 13:36:26 volumio volumio[8484]: info: sendMpdCommand clearerror took 10 milliseconds Mar 31 13:36:26 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 31 13:36:26 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 31 13:36:26 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:26 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:26 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:26 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:26 volumio volumio[8484]: 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":"stream","artist":"(#1 - 71/2000) Radio SRS Suriname","album":null,"uri":"https://38.242.219.45:8060/stream","trackType":""} Mar 31 13:36:26 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::syncState stateService stop Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:26 volumio volumio[8484]: info: No code Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:26 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:26 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:26 volumio volumio[8484]: 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":"stream","artist":"(#1 - 71/2000) Radio SRS Suriname","album":null,"uri":"https://38.242.219.45:8060/stream","trackType":""} Mar 31 13:36:26 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::syncState stateService stop Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:26 volumio volumio[8484]: info: No code Mar 31 13:36:26 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:26 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:26 volumio volumio[8484]: info: ------------------------------ 24ms Mar 31 13:36:26 volumio volumio[8484]: info: ------------------------------ 23ms Mar 31 13:36:31 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:31 volumio volumio[8484]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::ClearQueue Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:31 volumio volumio[8484]: info: CorePlayQueue::clearPlayQueue Mar 31 13:36:31 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:31 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::addQueueItems Mar 31 13:36:31 volumio volumio[8484]: info: CorePlayQueue::addQueueItems Mar 31 13:36:31 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:31 volumio volumio[8484]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99519473 Mar 31 13:36:31 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 31 13:36:31 volumio volumio[8484]: info: CoreCommandRouter::volumioPushQueue Mar 31 13:36:31 volumio volumio[8484]: info: CorePlayQueue::saveQueue Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::updateTrackBlock Mar 31 13:36:31 volumio volumio[8484]: info: CorePlayQueue::getTrackBlock Mar 31 13:36:31 volumio volumio[8484]: info: CoreCommandRouter::volumioPlay Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::play index 0 Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::stop Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::play index undefined Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 13:36:31 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::startPlaybackTimer Mar 31 13:36:31 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:31 volumio volumio[8484]: info: [1711892191358] ControllerWebradio::clearAddPlayTrack Mar 31 13:36:31 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 13:36:31 volumio volumio[8484]: info: sendMpdCommand stop took 1 milliseconds Mar 31 13:36:31 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand clear Mar 31 13:36:31 volumio volumio[8484]: info: Mar 31 13:36:31 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:31 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:31 volumio volumio[8484]: info: sendMpdCommand clear took 0 milliseconds Mar 31 13:36:31 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99519473" Mar 31 13:36:31 volumio volumio[8484]: info: Mar 31 13:36:31 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:31 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:31 volumio volumio[8484]: error: updateQueue error: null Mar 31 13:36:31 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:31 volumio volumio[8484]: info: Mar 31 13:36:31 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:31 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:31 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:31 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) Mar 31 13:36:31 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00000081/00006000 Mar 31 13:36:31 volumio kernel: ath10k_pci 0000:3a:00.0: [ 0] RxErr (First) Mar 31 13:36:31 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:31 volumio volumio[8484]: info: Mar 31 13:36:31 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:31 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:31 volumio volumio[8484]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99519473" took 318 milliseconds Mar 31 13:36:31 volumio volumio[8484]: info: ------------------------------ 319ms Mar 31 13:36:31 volumio volumio[8484]: info: ------------------------------ 318ms Mar 31 13:36:31 volumio volumio[8484]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 31 13:36:31 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand play Mar 31 13:36:31 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:31 volumio volumio[8484]: info: sendMpdCommand play took 0 milliseconds Mar 31 13:36:31 volumio volumio[8484]: info: Mar 31 13:36:31 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:31 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:31 volumio volumio[8484]: info: Mar 31 13:36:31 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:31 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:31 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:31 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 0 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: 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":"stream","artist":"(#1 - 67/100) 70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus stop Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 4ms Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: 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":"stream","artist":"(#1 - 67/100) 70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:33 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: 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":"stream","artist":"(#1 - 67/100) 70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:33 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: 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":"stream","artist":"(#1 - 67/100) 70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:33 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 16ms Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 16ms Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 15ms Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 14 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: 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":"stream","artist":"(#1 - 67/100) 70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:33 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 16ms Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: 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":"stream","artist":"(#1 - 67/100) 70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:33 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 21ms Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:33 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:33 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:33 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:33 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 0 milliseconds Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:33 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 0ms Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 1 milliseconds Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Renato Zero - I Nuovi Santi","artist":"70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:33 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Renato Zero - I Nuovi Santi","artist":"70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:33 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Renato Zero - I Nuovi Santi","artist":"70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:33 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 7ms Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 7ms Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 8ms Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces system playlist update Mar 31 13:36:33 volumio volumio[8484]: info: Ignoring MPD Status Update Mar 31 13:36:33 volumio volumio[8484]: info: Mar 31 13:36:33 volumio volumio[8484]: ---------------------------- MPD announces state update: player Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::getState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand status Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 1ms Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Renato Zero - I Nuovi Santi","artist":"70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:33 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Renato Zero - I Nuovi Santi","artist":"70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:33 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 12ms Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 11ms Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand status took 10 milliseconds Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseState Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 13:36:33 volumio volumio[8484]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 31 13:36:33 volumio volumio[8484]: verbose: ControllerMpd::parseTrackInfo Mar 31 13:36:33 volumio volumio[8484]: info: ControllerMpd::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::servicePushState Mar 31 13:36:33 volumio volumio[8484]: info: CorePlayQueue::getTrack 0 Mar 31 13:36:33 volumio volumio[8484]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Renato Zero - I Nuovi Santi","artist":"70 80 90 ITALIA D'AUTORE","album":null,"uri":"https://maggie.torontocast.com:8118/stream","trackType":""} Mar 31 13:36:33 volumio volumio[8484]: verbose: CURRENT POSITION 0 Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState stateService play Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::syncState currentStatus play Mar 31 13:36:33 volumio volumio[8484]: info: Received an update from plugin. extracting info from payload Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreStateMachine::pushState Mar 31 13:36:33 volumio volumio[8484]: info: CoreCommandRouter::volumioPushState Mar 31 13:36:33 volumio volumio[8484]: info: ------------------------------ 13ms Mar 31 13:36:33 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:33 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Receiver ID) Mar 31 13:36:33 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00000080/00006000 Mar 31 13:36:33 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:34 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:34 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Transmitter ID) Mar 31 13:36:34 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00001080/00006000 Mar 31 13:36:34 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:34 volumio kernel: ath10k_pci 0000:3a:00.0: [12] Timeout Mar 31 13:36:35 volumio volumio[8484]: error: error Mar 31 13:36:35 volumio volumio[8484]: error: error Mar 31 13:36:35 volumio volumio[8484]: error: error Mar 31 13:36:36 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:36 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) Mar 31 13:36:36 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00000081/00006000 Mar 31 13:36:36 volumio kernel: ath10k_pci 0000:3a:00.0: [ 0] RxErr (First) Mar 31 13:36:36 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:37 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:37 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) Mar 31 13:36:37 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00000081/00006000 Mar 31 13:36:37 volumio kernel: ath10k_pci 0000:3a:00.0: [ 0] RxErr (First) Mar 31 13:36:37 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:49 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:49 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Transmitter ID) Mar 31 13:36:49 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00001081/00006000 Mar 31 13:36:49 volumio kernel: ath10k_pci 0000:3a:00.0: [ 0] RxErr Mar 31 13:36:49 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:49 volumio kernel: ath10k_pci 0000:3a:00.0: [12] Timeout Mar 31 13:36:49 volumio kernel: pcieport 0000:00:1c.4: AER: Corrected error received: 0000:3a:00.0 Mar 31 13:36:52 volumio kernel: pcieport 0000:00:1c.4: AER: Corrected error received: 0000:3a:00.0 Mar 31 13:36:52 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) Mar 31 13:36:52 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00000001/00006000 Mar 31 13:36:52 volumio kernel: ath10k_pci 0000:3a:00.0: [ 0] RxErr (First) Mar 31 13:36:53 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:36:54 volumio kernel: pcieport 0000:00:1c.4: AER: Multiple Corrected error received: 0000:3a:00.0 Mar 31 13:36:54 volumio kernel: ath10k_pci 0000:3a:00.0: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) Mar 31 13:36:54 volumio kernel: ath10k_pci 0000:3a:00.0: device [168c:003e] error status/mask=00000081/00006000 Mar 31 13:36:54 volumio kernel: ath10k_pci 0000:3a:00.0: [ 0] RxErr (First) Mar 31 13:36:54 volumio kernel: ath10k_pci 0000:3a:00.0: [ 7] BadDLLP Mar 31 13:36:58 volumio volumio[8484]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 31 13:36:58 volumio volumio[8484]: info: CURURI: music-library Mar 31 13:36:58 volumio volumio[8484]: error: Failed LSINFO: null Mar 31 13:36:58 volumio volumio[8484]: info: Preload queue cleared Mar 31 13:37:04 volumio volumio[8484]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 31 13:37:04 volumio volumio[8484]: Error: connect ETIMEDOUT 199.59.148.201:80 Mar 31 13:37:04 volumio volumio[8484]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Mar 31 13:37:04 volumio volumio[8484]: errno: -110, Mar 31 13:37:04 volumio volumio[8484]: code: 'ETIMEDOUT', Mar 31 13:37:04 volumio volumio[8484]: syscall: 'connect', Mar 31 13:37:04 volumio volumio[8484]: address: '199.59.148.201', Mar 31 13:37:04 volumio volumio[8484]: port: 80 Mar 31 13:37:04 volumio volumio[8484]: } Mar 31 13:37:04 volumio volumio[8484]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 31 13:37:04 volumio sudo[8898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-31 13:36 Mar 31 13:37:04 volumio sudo[8898]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET" VOLUMIO_VERSION="3.634" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"