-- Logs begin at Thu 2019-02-14 12:11:59 EET, end at Wed 2025-05-07 12:19:42 EEST. -- May 07 12:18:00 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 12:18:01 pioneer volumio[24173]: info: Clearing queue after UPNP request May 07 12:18:02 pioneer volumio[24173]: info: CoreStateMachine::ClearQueue May 07 12:18:02 pioneer volumio[24173]: info: CoreStateMachine::stop May 07 12:18:02 pioneer volumio[24173]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 12:18:02 pioneer volumio[24173]: info: CorePlayQueue::clearPlayQueue May 07 12:18:02 pioneer volumio[24173]: info: CorePlayQueue::saveQueue May 07 12:18:02 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushState May 07 12:18:02 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushQueue May 07 12:18:02 pioneer volumio[24173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: error: updateQueue error: null May 07 12:18:02 pioneer volumio[24173]: error: updateQueue error: null May 07 12:18:02 pioneer volumio[24173]: error: updateQueue error: null May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 16ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 13ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 11ms May 07 12:18:02 pioneer volumio[24173]: info: Starting UPNP Playback May 07 12:18:02 pioneer volumio[24173]: info: Preparing playback through UPNP May 07 12:18:02 pioneer volumio[24173]: info: CoreCommandRouter::volumioGetState May 07 12:18:02 pioneer volumio[24173]: info: CorePlayQueue::getTrack 0 May 07 12:18:02 pioneer volumio[24173]: info: CoreStateMachine::setConsumeUpdateService mpd May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 10ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 8ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 6ms May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 10ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 7ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 5ms May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 9ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 7ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 4ms May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 9ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 6ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 5ms May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 9ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 6ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 5ms May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:02 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 9ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 7ms May 07 12:18:02 pioneer volumio[24173]: info: ------------------------------ 4ms May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces state update: player May 07 12:18:02 pioneer volumio[24173]: info: ControllerMpd::getState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand status May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces state update: player May 07 12:18:02 pioneer volumio[24173]: info: ControllerMpd::getState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand status May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces state update: player May 07 12:18:02 pioneer volumio[24173]: info: ControllerMpd::getState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand status May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces state update: player May 07 12:18:02 pioneer volumio[24173]: info: ControllerMpd::getState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand status May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces state update: player May 07 12:18:02 pioneer volumio[24173]: info: sendMpdCommand status took 15 milliseconds May 07 12:18:02 pioneer volumio[24173]: info: ControllerMpd::getState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand status May 07 12:18:02 pioneer volumio[24173]: info: sendMpdCommand status took 13 milliseconds May 07 12:18:02 pioneer volumio[24173]: info: sendMpdCommand status took 10 milliseconds May 07 12:18:02 pioneer volumio[24173]: info: sendMpdCommand status took 6 milliseconds May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::parseState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::parseState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::parseState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::parseState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 12:18:02 pioneer volumio[24173]: info: May 07 12:18:02 pioneer volumio[24173]: ---------------------------- MPD announces state update: player May 07 12:18:02 pioneer volumio[24173]: info: ControllerMpd::getState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand status May 07 12:18:02 pioneer volumio[24173]: info: sendMpdCommand status took 15 milliseconds May 07 12:18:02 pioneer volumio[24173]: info: sendMpdCommand playlistinfo took 12 milliseconds May 07 12:18:02 pioneer volumio[24173]: info: sendMpdCommand playlistinfo took 11 milliseconds May 07 12:18:02 pioneer volumio[24173]: info: sendMpdCommand playlistinfo took 11 milliseconds May 07 12:18:02 pioneer volumio[24173]: info: sendMpdCommand playlistinfo took 10 milliseconds May 07 12:18:02 pioneer volumio[24173]: info: sendMpdCommand status took 6 milliseconds May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::parseState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::parseTrackInfo May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::parseTrackInfo May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::parseTrackInfo May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::parseTrackInfo May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::parseState May 07 12:18:02 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 12:18:02 pioneer volumio[24173]: info: ControllerMpd::pushState May 07 12:18:02 pioneer volumio[24173]: info: CoreCommandRouter::servicePushState May 07 12:18:02 pioneer volumio[24173]: verbose: In UPNP mode May 07 12:18:02 pioneer volumio[24173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"swyh-rs","artist":null,"album":null,"uri":"http://192.168.0.14:5901/stream/swyh.raw","trackType":"raw"} May 07 12:18:02 pioneer volumio[24173]: verbose: CURRENT POSITION 0 May 07 12:18:02 pioneer volumio[24173]: info: CoreStateMachine::syncState stateService play May 07 12:18:02 pioneer volumio[24173]: info: CoreStateMachine::syncState currentStatus stop May 07 12:18:02 pioneer volumio[24173]: info: ControllerMpd::pushState May 07 12:18:02 pioneer volumio[24173]: info: CoreCommandRouter::servicePushState May 07 12:18:02 pioneer volumio[24173]: verbose: In UPNP mode May 07 12:18:02 pioneer volumio[24173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"swyh-rs","artist":null,"album":null,"uri":"http://192.168.0.14:5901/stream/swyh.raw","trackType":"raw"} May 07 12:18:02 pioneer volumio[24173]: verbose: CURRENT POSITION 0 May 07 12:18:02 pioneer volumio[24173]: info: CoreStateMachine::syncState stateService play May 07 12:18:02 pioneer volumio[24173]: info: CoreStateMachine::syncState currentStatus play May 07 12:18:02 pioneer volumio[24173]: info: Received an update from plugin. extracting info from payload May 07 12:18:02 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:02 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 07 12:18:02 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushState May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushState May 07 12:18:03 pioneer volumio[24173]: info: ControllerMpd::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::servicePushState May 07 12:18:03 pioneer volumio[24173]: verbose: In UPNP mode May 07 12:18:03 pioneer volumio[24173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"swyh-rs","artist":null,"album":null,"uri":"http://192.168.0.14:5901/stream/swyh.raw","trackType":"raw"} May 07 12:18:03 pioneer volumio[24173]: verbose: CURRENT POSITION 0 May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState stateService play May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState currentStatus play May 07 12:18:03 pioneer volumio[24173]: info: Received an update from plugin. extracting info from payload May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushState May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushState May 07 12:18:03 pioneer volumio[24173]: info: ControllerMpd::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::servicePushState May 07 12:18:03 pioneer volumio[24173]: verbose: In UPNP mode May 07 12:18:03 pioneer volumio[24173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"swyh-rs","artist":null,"album":null,"uri":"http://192.168.0.14:5901/stream/swyh.raw","trackType":"raw"} May 07 12:18:03 pioneer volumio[24173]: verbose: CURRENT POSITION 0 May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState stateService play May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState currentStatus play May 07 12:18:03 pioneer volumio[24173]: info: Received an update from plugin. extracting info from payload May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushState May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushState May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 98ms May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 163ms May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 161ms May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 158ms May 07 12:18:03 pioneer volumio[24173]: info: sendMpdCommand playlistinfo took 131 milliseconds May 07 12:18:03 pioneer volumio[24173]: info: sendMpdCommand playlistinfo took 127 milliseconds May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::parseTrackInfo May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::parseTrackInfo May 07 12:18:03 pioneer volumio[24173]: info: ControllerMpd::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::servicePushState May 07 12:18:03 pioneer volumio[24173]: verbose: In UPNP mode May 07 12:18:03 pioneer volumio[24173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"swyh-rs","artist":null,"album":null,"uri":"http://192.168.0.14:5901/stream/swyh.raw","trackType":"raw"} May 07 12:18:03 pioneer volumio[24173]: verbose: CURRENT POSITION 0 May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState stateService play May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState currentStatus play May 07 12:18:03 pioneer volumio[24173]: info: Received an update from plugin. extracting info from payload May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushState May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushState May 07 12:18:03 pioneer volumio[24173]: info: ControllerMpd::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::servicePushState May 07 12:18:03 pioneer volumio[24173]: verbose: In UPNP mode May 07 12:18:03 pioneer volumio[24173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"swyh-rs","artist":null,"album":null,"uri":"http://192.168.0.14:5901/stream/swyh.raw","trackType":"raw"} May 07 12:18:03 pioneer volumio[24173]: verbose: CURRENT POSITION 0 May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState stateService play May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState currentStatus play May 07 12:18:03 pioneer volumio[24173]: info: Received an update from plugin. extracting info from payload May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushState May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::volumioPushState May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 237ms May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 225ms May 07 12:18:03 pioneer volumio[24173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 07 12:18:03 pioneer volumio[24173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 07 12:18:03 pioneer volumio[24173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 07 12:18:03 pioneer volumio[24173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 07 12:18:03 pioneer volumio[24173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 07 12:18:03 pioneer volumio[24173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 07 12:18:03 pioneer volumio[24173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 07 12:18:03 pioneer volumio[24173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 07 12:18:03 pioneer volumio[24173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 07 12:18:03 pioneer volumio[24173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 07 12:18:03 pioneer volumio[24173]: info: May 07 12:18:03 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:03 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:03 pioneer volumio[24173]: info: May 07 12:18:03 pioneer volumio[24173]: ---------------------------- MPD announces state update: player May 07 12:18:03 pioneer volumio[24173]: info: ControllerMpd::getState May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand status May 07 12:18:03 pioneer volumio[24173]: info: May 07 12:18:03 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:03 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:03 pioneer volumio[24173]: info: May 07 12:18:03 pioneer volumio[24173]: ---------------------------- MPD announces state update: player May 07 12:18:03 pioneer volumio[24173]: info: ControllerMpd::getState May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand status May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 11ms May 07 12:18:03 pioneer volumio[24173]: info: sendMpdCommand status took 8 milliseconds May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 7ms May 07 12:18:03 pioneer volumio[24173]: info: sendMpdCommand status took 4 milliseconds May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::parseState May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::parseState May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 12:18:03 pioneer volumio[24173]: info: May 07 12:18:03 pioneer volumio[24173]: ---------------------------- MPD announces system playlist update May 07 12:18:03 pioneer volumio[24173]: info: Ignoring MPD Status Update May 07 12:18:03 pioneer volumio[24173]: info: May 07 12:18:03 pioneer volumio[24173]: ---------------------------- MPD announces state update: player May 07 12:18:03 pioneer volumio[24173]: info: ControllerMpd::getState May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand status May 07 12:18:03 pioneer volumio[24173]: info: sendMpdCommand playlistinfo took 9 milliseconds May 07 12:18:03 pioneer volumio[24173]: info: sendMpdCommand playlistinfo took 9 milliseconds May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 8ms May 07 12:18:03 pioneer volumio[24173]: info: sendMpdCommand status took 5 milliseconds May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::parseTrackInfo May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::parseTrackInfo May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::parseState May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 12:18:03 pioneer volumio[24173]: info: ControllerMpd::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::servicePushState May 07 12:18:03 pioneer volumio[24173]: verbose: In UPNP mode May 07 12:18:03 pioneer volumio[24173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"swyh.raw","artist":"swyh-rs","album":null,"uri":"http://192.168.0.14:5901/stream/swyh.raw","trackType":"raw"} May 07 12:18:03 pioneer volumio[24173]: verbose: CURRENT POSITION 0 May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState stateService play May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState currentStatus play May 07 12:18:03 pioneer volumio[24173]: info: Received an update from plugin. extracting info from payload May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CorePlayQueue::getTrack 0 May 07 12:18:03 pioneer volumio[24173]: info: ControllerMpd::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::servicePushState May 07 12:18:03 pioneer volumio[24173]: verbose: In UPNP mode May 07 12:18:03 pioneer volumio[24173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"swyh.raw","artist":"swyh-rs","album":null,"uri":"http://192.168.0.14:5901/stream/swyh.raw","trackType":"raw"} May 07 12:18:03 pioneer volumio[24173]: verbose: CURRENT POSITION 0 May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState stateService play May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState currentStatus play May 07 12:18:03 pioneer volumio[24173]: info: Received an update from plugin. extracting info from payload May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CorePlayQueue::getTrack 0 May 07 12:18:03 pioneer volumio[24173]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 07 12:18:03 pioneer volumio[24173]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 50ms May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 46ms May 07 12:18:03 pioneer volumio[24173]: info: sendMpdCommand playlistinfo took 25 milliseconds May 07 12:18:03 pioneer volumio[24173]: verbose: ControllerMpd::parseTrackInfo May 07 12:18:03 pioneer volumio[24173]: info: ControllerMpd::pushState May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::servicePushState May 07 12:18:03 pioneer volumio[24173]: verbose: In UPNP mode May 07 12:18:03 pioneer volumio[24173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"swyh.raw","artist":"swyh-rs","album":null,"uri":"http://192.168.0.14:5901/stream/swyh.raw","trackType":"raw"} May 07 12:18:03 pioneer volumio[24173]: verbose: CURRENT POSITION 0 May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState stateService play May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::syncState currentStatus play May 07 12:18:03 pioneer volumio[24173]: info: Received an update from plugin. extracting info from payload May 07 12:18:03 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 07 12:18:03 pioneer volumio[24173]: info: CoreStateMachine::pushState May 07 12:18:03 pioneer volumio[24173]: info: CorePlayQueue::getTrack 0 May 07 12:18:03 pioneer volumio[24173]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 07 12:18:03 pioneer volumio[24173]: info: ------------------------------ 50ms May 07 12:18:04 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 12:18:08 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 12:18:12 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 12:18:16 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 12:18:20 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 12:18:24 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 12:18:28 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 12:18:32 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 12:19:29 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 12:19:40 pioneer volumio[24173]: verbose: New Socket.io Connection to 192.168.0.27 from 192.168.0.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 07 12:19:40 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 12:19:40 pioneer volumio[24173]: info: CoreCommandRouter::volumioGetVisibleSources May 07 12:19:40 pioneer volumio[24173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 12:19:40 pioneer volumio[24173]: info: CoreCommandRouter::volumioGetState May 07 12:19:40 pioneer volumio[24173]: info: CorePlayQueue::getTrack 0 May 07 12:19:40 pioneer volumio[24173]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 12:19:40 pioneer volumio[24173]: TypeError: Cannot read property 'name' of undefined May 07 12:19:40 pioneer volumio[24173]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 07 12:19:40 pioneer volumio[24173]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) May 07 12:19:40 pioneer volumio[24173]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:58:38) May 07 12:19:40 pioneer volumio[24173]: at Socket.emit (events.js:400:28) May 07 12:19:40 pioneer volumio[24173]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 May 07 12:19:40 pioneer volumio[24173]: at processTicksAndRejections (internal/process/task_queues.js:77:11) May 07 12:19:40 pioneer volumio[24173]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 12:19:42 pioneer sudo[25173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-07 12:18 May 07 12:19:42 pioneer sudo[25173]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Sep 2024 10:02:06 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="orangepione" VOLUMIO_DEVICENAME="Orange Pi One" VOLUMIO_HASH="196dbf07455fd638bf5080f981aa4211"