-- Logs begin at Fri 2021-07-02 13:56:33 UTC, end at Sun 2025-01-19 05:21:00 UTC. -- Jan 19 05:20:00 volumio3 volumio[1099]: info: Jan 19 05:20:00 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:00 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:00 volumio3 volumio[1099]: info: Jan 19 05:20:00 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:00 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:00 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:00 volumio3 volumio[1099]: info: ------------------------------ 3ms Jan 19 05:20:00 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:00 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:00 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:00 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:00 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:00 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:00 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:00 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:00 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9688,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:00 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:00 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:00 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:00 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:00 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:00 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:00 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:00 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:00 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:00 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:00 volumio3 volumio[1099]: info: ------------------------------ 20ms Jan 19 05:20:02 volumio3 volumio[1099]: info: Jan 19 05:20:02 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:02 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:02 volumio3 volumio[1099]: info: Jan 19 05:20:02 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:02 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:02 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:02 volumio3 volumio[1099]: info: ------------------------------ 3ms Jan 19 05:20:02 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:02 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:02 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:02 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:02 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:02 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:02 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:02 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:02 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12080,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:02 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:02 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:02 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:02 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:02 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:02 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:02 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:02 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:02 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:02 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:02 volumio3 volumio[1099]: info: ------------------------------ 22ms Jan 19 05:20:05 volumio3 volumio[1099]: info: Jan 19 05:20:05 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:05 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:05 volumio3 volumio[1099]: info: Jan 19 05:20:05 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:05 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:05 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:05 volumio3 volumio[1099]: info: ------------------------------ 2ms Jan 19 05:20:05 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:05 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:05 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:05 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:05 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:05 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:05 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:05 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:05 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:05 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:05 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:05 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:05 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:05 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:05 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:05 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:05 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:05 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:05 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:05 volumio3 volumio[1099]: info: ------------------------------ 21ms Jan 19 05:20:07 volumio3 volumio[1099]: info: Jan 19 05:20:07 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:07 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:07 volumio3 volumio[1099]: info: Jan 19 05:20:07 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:07 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:07 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:07 volumio3 volumio[1099]: info: ------------------------------ 3ms Jan 19 05:20:07 volumio3 volumio[1099]: info: sendMpdCommand status took 1 milliseconds Jan 19 05:20:07 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:07 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:07 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:07 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:07 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:07 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:07 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:07 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17084,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:07 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:07 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:07 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:07 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:07 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:07 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:07 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:07 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:07 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:07 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:07 volumio3 volumio[1099]: info: ------------------------------ 20ms Jan 19 05:20:10 volumio3 volumio[1099]: info: Jan 19 05:20:10 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:10 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:10 volumio3 volumio[1099]: info: Jan 19 05:20:10 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:10 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:10 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:10 volumio3 volumio[1099]: info: ------------------------------ 3ms Jan 19 05:20:10 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:10 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:10 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:10 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:10 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:10 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:10 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:10 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:10 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":20079,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:10 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:10 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:10 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:10 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:10 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:10 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:10 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:10 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:10 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:10 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:10 volumio3 volumio[1099]: info: ------------------------------ 20ms Jan 19 05:20:11 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jan 19 05:20:13 volumio3 volumio[1099]: info: Jan 19 05:20:13 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:13 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:13 volumio3 volumio[1099]: info: Jan 19 05:20:13 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:13 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:13 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:13 volumio3 volumio[1099]: info: ------------------------------ 6ms Jan 19 05:20:13 volumio3 volumio[1099]: info: sendMpdCommand status took 4 milliseconds Jan 19 05:20:13 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:13 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:13 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 19 05:20:13 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:13 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:13 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:13 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:13 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22180,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:13 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:13 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:13 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:13 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:13 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:13 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:13 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:13 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:13 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:13 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:13 volumio3 volumio[1099]: info: ------------------------------ 22ms Jan 19 05:20:16 volumio3 volumio[1099]: info: Jan 19 05:20:16 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:16 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:16 volumio3 volumio[1099]: info: Jan 19 05:20:16 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:16 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:16 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:16 volumio3 volumio[1099]: info: ------------------------------ 4ms Jan 19 05:20:16 volumio3 volumio[1099]: info: sendMpdCommand status took 3 milliseconds Jan 19 05:20:16 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:16 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:16 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:16 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:16 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:16 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:16 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:16 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25280,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:16 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:16 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:16 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:16 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:16 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:16 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:16 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:16 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:16 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:16 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:16 volumio3 volumio[1099]: info: ------------------------------ 19ms Jan 19 05:20:18 volumio3 volumio[1099]: info: Jan 19 05:20:18 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:18 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:18 volumio3 volumio[1099]: info: Jan 19 05:20:18 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:18 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:18 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:18 volumio3 volumio[1099]: info: ------------------------------ 3ms Jan 19 05:20:18 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:18 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:18 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:18 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:18 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:18 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:18 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:18 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:18 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":27277,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:18 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:18 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:18 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:18 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:18 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:18 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:18 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:18 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:18 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:18 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:18 volumio3 volumio[1099]: info: ------------------------------ 22ms Jan 19 05:20:20 volumio3 volumio[1099]: info: Jan 19 05:20:20 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:20 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:20 volumio3 volumio[1099]: info: Jan 19 05:20:20 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:20 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:20 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:20 volumio3 volumio[1099]: info: ------------------------------ 3ms Jan 19 05:20:20 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:20 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:20 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:20 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:20 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:20 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:20 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:20 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:20 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29680,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:20 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:20 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:20 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:20 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:20 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:20 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:20 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:20 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:20 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:20 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:20 volumio3 volumio[1099]: info: ------------------------------ 19ms Jan 19 05:20:22 volumio3 volumio[1099]: info: Jan 19 05:20:22 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:22 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:22 volumio3 volumio[1099]: info: Jan 19 05:20:22 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:22 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:22 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:22 volumio3 volumio[1099]: info: ------------------------------ 3ms Jan 19 05:20:22 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:22 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:22 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:22 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:22 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:22 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:22 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:22 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:22 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31979,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:22 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:22 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:22 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:22 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:22 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:22 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:22 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:22 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:22 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:22 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:22 volumio3 volumio[1099]: info: ------------------------------ 18ms Jan 19 05:20:24 volumio3 volumio[1099]: info: Jan 19 05:20:24 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:24 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:24 volumio3 volumio[1099]: info: Jan 19 05:20:24 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:24 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:24 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:24 volumio3 volumio[1099]: info: ------------------------------ 3ms Jan 19 05:20:24 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:24 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:24 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:24 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 19 05:20:24 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:24 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:24 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:24 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:24 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34179,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:24 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:24 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:24 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:24 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:24 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:24 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:24 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:24 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:24 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:24 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:24 volumio3 volumio[1099]: info: ------------------------------ 22ms Jan 19 05:20:27 volumio3 volumio[1099]: info: Jan 19 05:20:27 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:27 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:27 volumio3 volumio[1099]: info: Jan 19 05:20:27 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:27 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:27 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:27 volumio3 volumio[1099]: info: ------------------------------ 3ms Jan 19 05:20:27 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:27 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:27 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:27 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:27 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:27 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:27 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:27 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:27 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":37082,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:27 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:27 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:27 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:27 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:27 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:27 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:27 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:27 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:27 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:27 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:27 volumio3 volumio[1099]: info: ------------------------------ 20ms Jan 19 05:20:30 volumio3 volumio[1099]: info: Jan 19 05:20:30 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:30 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:30 volumio3 volumio[1099]: info: Jan 19 05:20:30 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:30 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:30 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:30 volumio3 volumio[1099]: info: ------------------------------ 3ms Jan 19 05:20:30 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:30 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:30 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:30 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 19 05:20:30 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:30 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:30 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:30 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:30 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":39381,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:30 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:30 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:30 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:30 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:30 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:30 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:30 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:30 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:30 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:30 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:30 volumio3 volumio[1099]: info: ------------------------------ 20ms Jan 19 05:20:30 volumio3 volumio[1099]: info: Downloading plugin at http://plugins.volumio.org/plugins/volumio/armhf/music_service/personal_radio/personal_radio.zip Jan 19 05:20:32 volumio3 volumio[1099]: info: Jan 19 05:20:32 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:32 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:32 volumio3 volumio[1099]: info: Jan 19 05:20:32 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:32 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:32 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:32 volumio3 volumio[1099]: info: ------------------------------ 6ms Jan 19 05:20:32 volumio3 volumio[1099]: info: sendMpdCommand status took 4 milliseconds Jan 19 05:20:32 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:32 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:32 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 19 05:20:32 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:32 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:32 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:32 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:32 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":41482,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:32 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:32 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:32 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:32 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:32 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:32 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:32 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:32 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:32 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:32 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:32 volumio3 volumio[1099]: info: ------------------------------ 23ms Jan 19 05:20:32 volumio3 volumio[1099]: info: END DOWNLOAD: http://plugins.volumio.org/plugins/volumio/armhf/music_service/personal_radio/personal_radio.zip Jan 19 05:20:32 volumio3 volumio[1099]: info: Folder /tmp/plugins removed Jan 19 05:20:33 volumio3 volumio[1099]: info: Checking if plugin already exists Jan 19 05:20:33 volumio3 volumio[1099]: info: Rename folder Jan 19 05:20:33 volumio3 volumio[1099]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 05:20:33 volumio3 volumio[1099]: info: Move to category Jan 19 05:20:35 volumio3 volumio[1099]: info: Checking if install.sh is present Jan 19 05:20:35 volumio3 volumio[1099]: info: Executing install.sh Jan 19 05:20:35 volumio3 volumio[1099]: info: Jan 19 05:20:35 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:35 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:35 volumio3 volumio[1099]: info: Jan 19 05:20:35 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:35 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:35 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:35 volumio3 volumio[1099]: info: ------------------------------ 6ms Jan 19 05:20:35 volumio3 volumio[1099]: info: sendMpdCommand status took 5 milliseconds Jan 19 05:20:35 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:35 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:35 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 19 05:20:35 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:35 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:35 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:35 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:35 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":44384,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:35 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:35 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:35 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:35 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:35 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:35 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:35 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:35 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:35 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:35 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:35 volumio3 volumio[1099]: info: ------------------------------ 37ms Jan 19 05:20:35 volumio3 sudo[3929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/personal_radio/install.sh Jan 19 05:20:35 volumio3 sudo[3929]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 05:20:35 volumio3 sudo[3929]: pam_unix(sudo:session): session closed for user root Jan 19 05:20:35 volumio3 volumio[1099]: info: Install script completed Jan 19 05:20:35 volumio3 volumio[1099]: info: Adding reference to registry Jan 19 05:20:35 volumio3 volumio[1099]: info: Done installing plugin. Jan 19 05:20:35 volumio3 volumio[1099]: info: Installing PersonalRadio Plugin Dependencies Jan 19 05:20:35 volumio3 volumio[1099]: info: PersonalRadio plugin installed Jan 19 05:20:35 volumio3 volumio[1099]: info: Folder /tmp/plugins removed Jan 19 05:20:35 volumio3 volumio[1099]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 05:20:35 volumio3 volumio[1099]: info: Folder /data/temp removed Jan 19 05:20:37 volumio3 volumio[1099]: info: Jan 19 05:20:37 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:37 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:37 volumio3 volumio[1099]: info: Jan 19 05:20:37 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:37 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:37 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:37 volumio3 volumio[1099]: info: ------------------------------ 3ms Jan 19 05:20:37 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:37 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:37 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:37 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:37 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:37 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:37 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:37 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:37 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46788,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:37 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:37 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:37 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:37 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:37 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:37 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:37 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:37 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:37 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:37 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:37 volumio3 volumio[1099]: info: ------------------------------ 18ms Jan 19 05:20:39 volumio3 volumio[1099]: info: Enabling plugin personal_radio Jan 19 05:20:39 volumio3 volumio[1099]: info: Loading plugin "personal_radio"... Jan 19 05:20:40 volumio3 volumio[1099]: info: ControllerPersonalRadio::constructor Jan 19 05:20:40 volumio3 volumio[1099]: info: PLUGIN START: personal_radio Jan 19 05:20:40 volumio3 volumio[1099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 19 05:20:40 volumio3 volumio[1099]: info: [1737264040112] CoreMusicLibrary::Adding element 개인 라디오 Jan 19 05:20:40 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 19 05:20:40 volumio3 volumio[1099]: info: Done. Jan 19 05:20:40 volumio3 volumio[1099]: info: Jan 19 05:20:40 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:40 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:40 volumio3 volumio[1099]: info: Jan 19 05:20:40 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:40 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:40 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:40 volumio3 volumio[1099]: info: ------------------------------ 11ms Jan 19 05:20:40 volumio3 volumio[1099]: info: sendMpdCommand status took 7 milliseconds Jan 19 05:20:40 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:40 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:40 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 19 05:20:40 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:40 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:40 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:40 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:40 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49586,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:40 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:40 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:40 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:40 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:40 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:40 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:40 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:40 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:40 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:40 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:40 volumio3 volumio[1099]: info: ------------------------------ 30ms Jan 19 05:20:42 volumio3 volumio[1099]: info: Jan 19 05:20:42 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:42 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:42 volumio3 volumio[1099]: info: Jan 19 05:20:42 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:42 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:42 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:42 volumio3 volumio[1099]: info: ------------------------------ 5ms Jan 19 05:20:42 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:42 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:42 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:42 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 19 05:20:42 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:42 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:42 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:42 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:42 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51583,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:42 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:42 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:42 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:42 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:42 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:42 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:42 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:42 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:42 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:42 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:42 volumio3 volumio[1099]: info: ------------------------------ 23ms Jan 19 05:20:44 volumio3 volumio[1099]: info: Jan 19 05:20:44 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:44 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:44 volumio3 volumio[1099]: info: Jan 19 05:20:44 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:44 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:44 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:44 volumio3 volumio[1099]: info: ------------------------------ 4ms Jan 19 05:20:44 volumio3 volumio[1099]: info: sendMpdCommand status took 2 milliseconds Jan 19 05:20:44 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:44 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:44 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:44 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:44 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:44 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:44 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:44 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":54183,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:44 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:44 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:44 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:44 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:44 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:44 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:44 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:44 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:44 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:44 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:44 volumio3 volumio[1099]: info: ------------------------------ 20ms Jan 19 05:20:47 volumio3 volumio[1099]: info: Jan 19 05:20:47 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:47 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:47 volumio3 volumio[1099]: info: Jan 19 05:20:47 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:47 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:47 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:47 volumio3 volumio[1099]: info: ------------------------------ 4ms Jan 19 05:20:47 volumio3 volumio[1099]: info: sendMpdCommand status took 5 milliseconds Jan 19 05:20:47 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:47 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:47 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 19 05:20:47 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:47 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:47 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:47 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:47 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":56679,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:47 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:47 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:47 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:47 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:47 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:47 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:47 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:47 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:47 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:47 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:47 volumio3 volumio[1099]: info: ------------------------------ 25ms Jan 19 05:20:50 volumio3 volumio[1099]: info: Jan 19 05:20:50 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:50 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:50 volumio3 volumio[1099]: info: Jan 19 05:20:50 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:50 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:50 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:50 volumio3 volumio[1099]: info: ------------------------------ 10ms Jan 19 05:20:50 volumio3 volumio[1099]: info: sendMpdCommand status took 4 milliseconds Jan 19 05:20:50 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:50 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:50 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 19 05:20:50 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:50 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:50 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:50 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:50 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":59385,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:50 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:50 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:50 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:50 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:50 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:50 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:50 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:50 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:50 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:50 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:50 volumio3 volumio[1099]: info: ------------------------------ 34ms Jan 19 05:20:52 volumio3 volumio[1099]: info: Jan 19 05:20:52 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:52 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:52 volumio3 volumio[1099]: info: Jan 19 05:20:52 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:52 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:52 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:52 volumio3 volumio[1099]: info: ------------------------------ 6ms Jan 19 05:20:52 volumio3 volumio[1099]: info: sendMpdCommand status took 3 milliseconds Jan 19 05:20:52 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:52 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:52 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:52 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:52 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:52 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:52 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:52 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61683,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:52 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:52 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:52 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:52 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:52 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:52 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:52 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:52 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:52 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:52 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:52 volumio3 volumio[1099]: info: ------------------------------ 22ms Jan 19 05:20:54 volumio3 volumio[1099]: info: Jan 19 05:20:54 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:54 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:54 volumio3 volumio[1099]: info: Jan 19 05:20:54 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:54 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:54 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:54 volumio3 volumio[1099]: info: ------------------------------ 4ms Jan 19 05:20:54 volumio3 volumio[1099]: info: sendMpdCommand status took 3 milliseconds Jan 19 05:20:54 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:54 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:54 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 19 05:20:54 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:54 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:54 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:54 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:54 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:54 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:54 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:54 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:54 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:54 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:54 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:54 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:54 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:54 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:54 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:54 volumio3 volumio[1099]: info: ------------------------------ 21ms Jan 19 05:20:55 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Jan 19 05:20:57 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Jan 19 05:20:57 volumio3 volumio[1099]: info: Jan 19 05:20:57 volumio3 volumio[1099]: ---------------------------- MPD announces system playlist update Jan 19 05:20:57 volumio3 volumio[1099]: info: Ignoring MPD Status Update Jan 19 05:20:57 volumio3 volumio[1099]: info: Jan 19 05:20:57 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:57 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:57 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:57 volumio3 volumio[1099]: info: ------------------------------ 13ms Jan 19 05:20:57 volumio3 volumio[1099]: info: sendMpdCommand status took 9 milliseconds Jan 19 05:20:57 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:57 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:57 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 19 05:20:57 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:57 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:57 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:57 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:57 volumio3 volumio[1099]: verbose: STATE SERVICE {"status":"play","position":0,"seek":66986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:57 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:57 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService play Jan 19 05:20:57 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus play Jan 19 05:20:57 volumio3 volumio[1099]: info: Received an update from plugin. extracting info from payload Jan 19 05:20:57 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:57 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:57 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:57 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:57 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:57 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:57 volumio3 volumio[1099]: info: ------------------------------ 42ms Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::ClearQueue Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::stop Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 05:20:59 volumio3 volumio[1099]: UNSET VOLATILE Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::stPlaybackTimer Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::updateTrackBlock Jan 19 05:20:59 volumio3 volumio[1099]: info: CorePlayQueue::getTrackBlock Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:59 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::serviceStop Jan 19 05:20:59 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::serviceStop Jan 19 05:20:59 volumio3 volumio[1099]: info: [1737264059396] ControllerWebradio::stop Jan 19 05:20:59 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 05:20:59 volumio3 volumio[1099]: info: CorePlayQueue::clearPlayQueue Jan 19 05:20:59 volumio3 volumio[1099]: info: CorePlayQueue::saveQueue Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushQueue Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::addQueueItems Jan 19 05:20:59 volumio3 volumio[1099]: info: CorePlayQueue::addQueueItems Jan 19 05:20:59 volumio3 volumio[1099]: info: Adding Item to queue: webkbs/0 Jan 19 05:20:59 volumio3 volumio[1099]: info: Exploding uri webkbs/0 in service personal_radio Jan 19 05:20:59 volumio3 volumio[1099]: info: Jan 19 05:20:59 volumio3 volumio[1099]: ---------------------------- MPD announces state update: player Jan 19 05:20:59 volumio3 volumio[1099]: info: sendMpdCommand stop took 79 milliseconds Jan 19 05:20:59 volumio3 volumio[1099]: info: ControllerMpd::getState Jan 19 05:20:59 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Jan 19 05:20:59 volumio3 volumio[1099]: info: sendMpdCommand status took 1 milliseconds Jan 19 05:20:59 volumio3 volumio[1099]: verbose: ControllerMpd::parseState Jan 19 05:20:59 volumio3 volumio[1099]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 05:20:59 volumio3 volumio[1099]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 19 05:20:59 volumio3 volumio[1099]: verbose: ControllerMpd::parseTrackInfo Jan 19 05:20:59 volumio3 volumio[1099]: info: ControllerMpd::pushState Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::servicePushState Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:59 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:59 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:59 volumio3 volumio[1099]: 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":"Edward Elgar, Sheku Kanneh-Mason - Cello Concerto in E minor Opus 85 (3)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Jan 19 05:20:59 volumio3 volumio[1099]: verbose: CURRENT POSITION 0 Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::syncState stateService stop Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::syncState currentStatus stop Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:59 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:59 volumio3 volumio[1099]: info: No code Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreStateMachine::pushState Jan 19 05:20:59 volumio3 volumio[1099]: info: CorePlayQueue::getTrack 0 Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::volumioPushState Jan 19 05:20:59 volumio3 volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 05:20:59 volumio3 volumio[1099]: info: ------------------------------ 24ms Jan 19 05:20:59 volumio3 volumio[1099]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 05:20:59 volumio3 volumio[1099]: ReferenceError: self is not defined Jan 19 05:20:59 volumio3 volumio[1099]: at ControllerPersonalRadio.errorToast (/data/plugins/music_service/personal_radio/index.js:575:22) Jan 19 05:20:59 volumio3 volumio[1099]: at /data/plugins/music_service/personal_radio/index.js:487:12 Jan 19 05:20:59 volumio3 volumio[1099]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:355:15) Jan 19 05:20:59 volumio3 volumio[1099]: at self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22) Jan 19 05:20:59 volumio3 volumio[1099]: at emitOne (events.js:116:13) Jan 19 05:20:59 volumio3 volumio[1099]: at Request.emit (events.js:211:7) Jan 19 05:20:59 volumio3 volumio[1099]: at Request.onRequestError (/data/plugins/music_service/personal_radio/node_modules/request/request.js:813:8) Jan 19 05:20:59 volumio3 volumio[1099]: at emitOne (events.js:116:13) Jan 19 05:20:59 volumio3 volumio[1099]: at ClientRequest.emit (events.js:211:7) Jan 19 05:20:59 volumio3 volumio[1099]: at Socket.socketErrorListener (_http_client.js:387:9) Jan 19 05:20:59 volumio3 volumio[1099]: at emitOne (events.js:116:13) Jan 19 05:20:59 volumio3 volumio[1099]: at Socket.emit (events.js:211:7) Jan 19 05:20:59 volumio3 volumio[1099]: at emitErrorNT (internal/streams/destroy.js:64:8) Jan 19 05:20:59 volumio3 volumio[1099]: at _combinedTickCallback (internal/process/next_tick.js:138:11) Jan 19 05:20:59 volumio3 volumio[1099]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 19 05:20:59 volumio3 volumio[1099]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 05:21:00 volumio3 sudo[4012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-19 05:20 Jan 19 05:21:00 volumio3 sudo[4012]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6" VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021" VOLUMIO_VERSION="2.907" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"