Jan 09 21:53:25 volumio7 volumio[1112]: info: CoreCommandRouter::volumioGetQueue Jan 09 21:53:25 volumio7 volumio[1112]: info: CoreStateMachine::getQueue Jan 09 21:53:25 volumio7 volumio[1112]: info: CorePlayQueue::getQueue Jan 09 21:53:32 volumio7 volumio[1112]: info: Preload queue cleared Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::ClearQueue Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::stop Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::stPlaybackTimer Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::updateTrackBlock Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::getTrackBlock Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::serviceStop Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::serviceStop Jan 09 21:53:32 volumio7 volumio[1112]: info: [1767966812153] ControllerWebradio::stop Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::clearPlayQueue Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::saveQueue Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushQueue Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::addQueueItems Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::addQueueItems Jan 09 21:53:32 volumio7 volumio[1112]: info: Preload queue cleared Jan 09 21:53:32 volumio7 volumio[1112]: info: Adding Item to queue: http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8 Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushQueue Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::saveQueue Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::updateTrackBlock Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::getTrackBlock Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPlay Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::play index 0 Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::stop Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::play index undefined Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::startPlaybackTimer Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:32 volumio7 volumio[1112]: info: [1767966812220] ControllerWebradio::clearAddPlayTrack Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 21:53:32 volumio7 volumio[1112]: info: Jan 09 21:53:32 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:32 volumio7 volumio[1112]: info: sendMpdCommand stop took 86 milliseconds Jan 09 21:53:32 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:32 volumio7 volumio[1112]: info: sendMpdCommand stop took 21 milliseconds Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand clear Jan 09 21:53:32 volumio7 volumio[1112]: info: Jan 09 21:53:32 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:32 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:32 volumio7 volumio[1112]: info: Jan 09 21:53:32 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:32 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:32 volumio7 volumio[1112]: info: Jan 09 21:53:32 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:32 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:32 volumio7 volumio[1112]: info: sendMpdCommand status took 17 milliseconds Jan 09 21:53:32 volumio7 volumio[1112]: info: sendMpdCommand clear took 15 milliseconds Jan 09 21:53:32 volumio7 volumio[1112]: info: sendMpdCommand status took 13 milliseconds Jan 09 21:53:32 volumio7 volumio[1112]: info: sendMpdCommand status took 11 milliseconds Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand add "http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8" Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:32 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:32 volumio7 volumio[1112]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 09 21:53:32 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:32 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:32 volumio7 volumio[1112]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 09 21:53:32 volumio7 volumio[1112]: info: ------------------------------ 59ms Jan 09 21:53:32 volumio7 volumio[1112]: info: ------------------------------ 57ms Jan 09 21:53:32 volumio7 volumio[1112]: info: Jan 09 21:53:32 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:32 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:32 volumio7 volumio[1112]: info: Jan 09 21:53:32 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:32 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:32 volumio7 volumio[1112]: error: updateQueue error: null Jan 09 21:53:32 volumio7 volumio[1112]: info: Jan 09 21:53:32 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:32 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:32 volumio7 volumio[1112]: info: ------------------------------ 69ms Jan 09 21:53:32 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 64 milliseconds Jan 09 21:53:32 volumio7 volumio[1112]: info: sendMpdCommand add "http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8" took 64 milliseconds Jan 09 21:53:32 volumio7 volumio[1112]: info: ------------------------------ 20ms Jan 09 21:53:32 volumio7 volumio[1112]: info: ------------------------------ 18ms Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:32 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 21:53:32 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand play Jan 09 21:53:32 volumio7 volumio[1112]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 21:53:32 volumio7 volumio[1112]: info: ------------------------------ 93ms Jan 09 21:53:32 volumio7 volumio[1112]: info: Jan 09 21:53:32 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:32 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:32 volumio7 volumio[1112]: info: Jan 09 21:53:32 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:32 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:32 volumio7 volumio[1112]: info: ------------------------------ 40ms Jan 09 21:53:32 volumio7 volumio[1112]: info: sendMpdCommand play took 33 milliseconds Jan 09 21:53:32 volumio7 volumio[1112]: info: ------------------------------ 30ms Jan 09 21:53:32 volumio7 volumio[1112]: info: ------------------------------ 28ms Jan 09 21:53:32 volumio7 volumio[1112]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X' Jan 09 21:53:36 volumio7 volumio[1112]: info: Jan 09 21:53:36 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:36 volumio7 volumio[1112]: info: Jan 09 21:53:36 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:36 volumio7 volumio[1112]: info: Jan 09 21:53:36 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand status took 44 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:36 volumio7 volumio[1112]: info: Jan 09 21:53:36 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:36 volumio7 volumio[1112]: info: Jan 09 21:53:36 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand status took 64 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand status took 62 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand status took 8 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:36 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one.m3u8","artist":null,"album":null,"uri":"http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8","trackType":"m3u8"} Jan 09 21:53:36 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus stop Jan 09 21:53:36 volumio7 volumio[1112]: info: ------------------------------ 87ms Jan 09 21:53:36 volumio7 volumio[1112]: info: Jan 09 21:53:36 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand status took 28 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 23 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 22 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 19 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand status took 12 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:36 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one.m3u8","artist":null,"album":null,"uri":"http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8","trackType":"m3u8"} Jan 09 21:53:36 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:36 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:36 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one.m3u8","artist":null,"album":null,"uri":"http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8","trackType":"m3u8"} Jan 09 21:53:36 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:36 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:36 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one.m3u8","artist":null,"album":null,"uri":"http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8","trackType":"m3u8"} Jan 09 21:53:36 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:36 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:36 volumio7 volumio[1112]: info: ------------------------------ 256ms Jan 09 21:53:36 volumio7 volumio[1112]: info: ------------------------------ 257ms Jan 09 21:53:36 volumio7 volumio[1112]: info: ------------------------------ 202ms Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 165 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 161 milliseconds Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:36 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:36 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one.m3u8","artist":null,"album":null,"uri":"http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8","trackType":"m3u8"} Jan 09 21:53:36 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:36 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:36 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:36 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one.m3u8","artist":null,"album":null,"uri":"http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8","trackType":"m3u8"} Jan 09 21:53:36 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:36 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:36 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:36 volumio7 volumio[1112]: info: ------------------------------ 305ms Jan 09 21:53:36 volumio7 volumio[1112]: info: ------------------------------ 285ms Jan 09 21:53:43 volumio7 volumio[1112]: info: Preload queue cleared Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::ClearQueue Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::stop Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::stPlaybackTimer Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::updateTrackBlock Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::getTrackBlock Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::serviceStop Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::serviceStop Jan 09 21:53:43 volumio7 volumio[1112]: info: [1767966823324] ControllerWebradio::stop Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::clearPlayQueue Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::saveQueue Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushQueue Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::addQueueItems Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::addQueueItems Jan 09 21:53:43 volumio7 volumio[1112]: info: Preload queue cleared Jan 09 21:53:43 volumio7 volumio[1112]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_62063831/live/ww/bbc_radio_one_dance/bbc_radio_one_dance.isml/bbc_radio_one_dance-audio%3d128000.norewind.m3u8 Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushQueue Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::saveQueue Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::updateTrackBlock Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::getTrackBlock Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPlay Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::play index 0 Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::stop Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::play index undefined Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::startPlaybackTimer Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:43 volumio7 volumio[1112]: info: [1767966823366] ControllerWebradio::clearAddPlayTrack Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 21:53:43 volumio7 volumio[1112]: info: Jan 09 21:53:43 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:43 volumio7 volumio[1112]: info: sendMpdCommand stop took 60 milliseconds Jan 09 21:53:43 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:43 volumio7 volumio[1112]: info: sendMpdCommand stop took 17 milliseconds Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand clear Jan 09 21:53:43 volumio7 volumio[1112]: info: Jan 09 21:53:43 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:43 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:43 volumio7 volumio[1112]: info: Jan 09 21:53:43 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:43 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:43 volumio7 volumio[1112]: info: Jan 09 21:53:43 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:43 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:43 volumio7 volumio[1112]: info: sendMpdCommand status took 19 milliseconds Jan 09 21:53:43 volumio7 volumio[1112]: info: sendMpdCommand clear took 18 milliseconds Jan 09 21:53:43 volumio7 volumio[1112]: info: sendMpdCommand status took 16 milliseconds Jan 09 21:53:43 volumio7 volumio[1112]: info: sendMpdCommand status took 14 milliseconds Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_62063831/live/ww/bbc_radio_one_dance/bbc_radio_one_dance.isml/bbc_radio_one_dance-audio%3d128000.norewind.m3u8" Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:43 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:43 volumio7 volumio[1112]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 09 21:53:43 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:43 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:43 volumio7 volumio[1112]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 09 21:53:43 volumio7 volumio[1112]: info: ------------------------------ 66ms Jan 09 21:53:43 volumio7 volumio[1112]: info: ------------------------------ 65ms Jan 09 21:53:43 volumio7 volumio[1112]: info: Jan 09 21:53:43 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:43 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:43 volumio7 volumio[1112]: info: Jan 09 21:53:43 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:43 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:43 volumio7 volumio[1112]: error: updateQueue error: null Jan 09 21:53:43 volumio7 volumio[1112]: info: Jan 09 21:53:43 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:43 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:43 volumio7 volumio[1112]: info: ------------------------------ 66ms Jan 09 21:53:43 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 61 milliseconds Jan 09 21:53:43 volumio7 volumio[1112]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_62063831/live/ww/bbc_radio_one_dance/bbc_radio_one_dance.isml/bbc_radio_one_dance-audio%3d128000.norewind.m3u8" took 60 milliseconds Jan 09 21:53:43 volumio7 volumio[1112]: info: ------------------------------ 14ms Jan 09 21:53:43 volumio7 volumio[1112]: info: ------------------------------ 12ms Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:43 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 21:53:43 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand play Jan 09 21:53:43 volumio7 volumio[1112]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 21:53:43 volumio7 volumio[1112]: info: ------------------------------ 91ms Jan 09 21:53:43 volumio7 volumio[1112]: info: Jan 09 21:53:43 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:43 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:43 volumio7 volumio[1112]: info: Jan 09 21:53:43 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:43 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:43 volumio7 volumio[1112]: info: ------------------------------ 30ms Jan 09 21:53:43 volumio7 volumio[1112]: info: sendMpdCommand play took 25 milliseconds Jan 09 21:53:43 volumio7 volumio[1112]: info: ------------------------------ 22ms Jan 09 21:53:43 volumio7 volumio[1112]: info: ------------------------------ 20ms Jan 09 21:53:43 volumio7 volumio[1112]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X' Jan 09 21:53:45 volumio7 volumio[1112]: info: Jan 09 21:53:45 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:45 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:45 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:45 volumio7 volumio[1112]: info: Jan 09 21:53:45 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:45 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:45 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:45 volumio7 volumio[1112]: info: Jan 09 21:53:45 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:45 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:45 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:46 volumio7 volumio[1112]: info: Jan 09 21:53:46 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand status took 50 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand status took 49 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand status took 47 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:46 volumio7 volumio[1112]: info: Jan 09 21:53:46 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:46 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:46 volumio7 volumio[1112]: info: Jan 09 21:53:46 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:46 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand status took 18 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 16 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 15 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 15 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand status took 11 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand status took 8 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:46 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:46 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one_dance-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_62063831/live/ww/bbc_radio_one_dance/bbc_radio_one_dance.isml/bbc_radio_one_dance-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:46 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus stop Jan 09 21:53:46 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:46 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":546,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one_dance-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_62063831/live/ww/bbc_radio_one_dance/bbc_radio_one_dance.isml/bbc_radio_one_dance-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:46 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:46 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:46 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:46 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":610,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one_dance-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_62063831/live/ww/bbc_radio_one_dance/bbc_radio_one_dance.isml/bbc_radio_one_dance-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:46 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:46 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:46 volumio7 volumio[1112]: info: ------------------------------ 132ms Jan 09 21:53:46 volumio7 volumio[1112]: info: ------------------------------ 176ms Jan 09 21:53:46 volumio7 volumio[1112]: info: ------------------------------ 175ms Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 103 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 98 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 97 milliseconds Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:46 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:46 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:46 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one_dance-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_62063831/live/ww/bbc_radio_one_dance/bbc_radio_one_dance.isml/bbc_radio_one_dance-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:46 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:46 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:46 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:46 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one_dance-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_62063831/live/ww/bbc_radio_one_dance/bbc_radio_one_dance.isml/bbc_radio_one_dance-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:46 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:46 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:46 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:46 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one_dance-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_62063831/live/ww/bbc_radio_one_dance/bbc_radio_one_dance.isml/bbc_radio_one_dance-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:46 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:46 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:46 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:46 volumio7 volumio[1112]: info: ------------------------------ 243ms Jan 09 21:53:46 volumio7 volumio[1112]: info: ------------------------------ 229ms Jan 09 21:53:46 volumio7 volumio[1112]: info: ------------------------------ 227ms Jan 09 21:53:56 volumio7 volumio[1112]: info: Preload queue cleared Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::ClearQueue Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::stop Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::stPlaybackTimer Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::updateTrackBlock Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::getTrackBlock Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::serviceStop Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::serviceStop Jan 09 21:53:56 volumio7 volumio[1112]: info: [1767966836695] ControllerWebradio::stop Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::clearPlayQueue Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::saveQueue Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushQueue Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::addQueueItems Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::addQueueItems Jan 09 21:53:56 volumio7 volumio[1112]: info: Preload queue cleared Jan 09 21:53:56 volumio7 volumio[1112]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8 Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushQueue Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::saveQueue Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::updateTrackBlock Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::getTrackBlock Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPlay Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::play index 0 Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::stop Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::play index undefined Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::startPlaybackTimer Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:56 volumio7 volumio[1112]: info: [1767966836734] ControllerWebradio::clearAddPlayTrack Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 21:53:56 volumio7 volumio[1112]: info: Jan 09 21:53:56 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:56 volumio7 volumio[1112]: info: sendMpdCommand stop took 56 milliseconds Jan 09 21:53:56 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:56 volumio7 volumio[1112]: info: sendMpdCommand stop took 17 milliseconds Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand clear Jan 09 21:53:56 volumio7 volumio[1112]: info: Jan 09 21:53:56 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:56 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:56 volumio7 volumio[1112]: info: Jan 09 21:53:56 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:56 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:56 volumio7 volumio[1112]: info: Jan 09 21:53:56 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:56 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:56 volumio7 volumio[1112]: info: sendMpdCommand status took 22 milliseconds Jan 09 21:53:56 volumio7 volumio[1112]: info: sendMpdCommand clear took 20 milliseconds Jan 09 21:53:56 volumio7 volumio[1112]: info: sendMpdCommand status took 19 milliseconds Jan 09 21:53:56 volumio7 volumio[1112]: info: sendMpdCommand status took 17 milliseconds Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8" Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:56 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:56 volumio7 volumio[1112]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 09 21:53:56 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:56 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:56 volumio7 volumio[1112]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 09 21:53:56 volumio7 volumio[1112]: info: ------------------------------ 60ms Jan 09 21:53:56 volumio7 volumio[1112]: info: ------------------------------ 59ms Jan 09 21:53:56 volumio7 volumio[1112]: info: Jan 09 21:53:56 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:56 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:56 volumio7 volumio[1112]: info: Jan 09 21:53:56 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:56 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:56 volumio7 volumio[1112]: error: updateQueue error: null Jan 09 21:53:56 volumio7 volumio[1112]: info: Jan 09 21:53:56 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:56 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:56 volumio7 volumio[1112]: info: ------------------------------ 55ms Jan 09 21:53:56 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 49 milliseconds Jan 09 21:53:56 volumio7 volumio[1112]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8" took 50 milliseconds Jan 09 21:53:56 volumio7 volumio[1112]: info: ------------------------------ 10ms Jan 09 21:53:56 volumio7 volumio[1112]: info: ------------------------------ 8ms Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:56 volumio7 volumio[1112]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 21:53:56 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand play Jan 09 21:53:56 volumio7 volumio[1112]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 21:53:56 volumio7 volumio[1112]: info: ------------------------------ 82ms Jan 09 21:53:56 volumio7 volumio[1112]: info: Jan 09 21:53:56 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:56 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:56 volumio7 volumio[1112]: info: Jan 09 21:53:56 volumio7 volumio[1112]: ---------------------------- MPD announces system playlist update Jan 09 21:53:56 volumio7 volumio[1112]: info: Ignoring MPD Status Update Jan 09 21:53:56 volumio7 volumio[1112]: info: ------------------------------ 28ms Jan 09 21:53:56 volumio7 volumio[1112]: info: sendMpdCommand play took 23 milliseconds Jan 09 21:53:56 volumio7 volumio[1112]: info: ------------------------------ 21ms Jan 09 21:53:56 volumio7 volumio[1112]: info: ------------------------------ 19ms Jan 09 21:53:56 volumio7 volumio[1112]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X' Jan 09 21:53:59 volumio7 volumio[1112]: info: Jan 09 21:53:59 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:59 volumio7 volumio[1112]: info: Jan 09 21:53:59 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:59 volumio7 volumio[1112]: info: Jan 09 21:53:59 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:59 volumio7 volumio[1112]: info: Jan 09 21:53:59 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand status took 37 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:59 volumio7 volumio[1112]: info: Jan 09 21:53:59 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand status took 44 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand status took 43 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:59 volumio7 volumio[1112]: info: Jan 09 21:53:59 volumio7 volumio[1112]: ---------------------------- MPD announces state update: player Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::getState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand status took 25 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 26 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand status took 24 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 17 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 17 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand status took 12 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseState Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:59 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:59 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus stop Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:59 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:59 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:59 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:59 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":726,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:59 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:59 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:59 volumio7 volumio[1112]: info: ------------------------------ 133ms Jan 09 21:53:59 volumio7 volumio[1112]: info: ------------------------------ 165ms Jan 09 21:53:59 volumio7 volumio[1112]: info: ------------------------------ 163ms Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 93 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 88 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: info: sendMpdCommand playlistinfo took 83 milliseconds Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:59 volumio7 volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:59 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":788,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:59 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:59 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:59 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:59 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:59 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:53:59 volumio7 volumio[1112]: info: ControllerMpd::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::servicePushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:59 volumio7 volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_one-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Jan 09 21:53:59 volumio7 volumio[1112]: verbose: CURRENT POSITION 0 Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState stateService play Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::syncState currentStatus play Jan 09 21:53:59 volumio7 volumio[1112]: info: Received an update from plugin. extracting info from payload Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:53:59 volumio7 volumio[1112]: info: CorePlayQueue::getTrack 0 Jan 09 21:53:59 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:54:00 volumio7 volumio[1112]: info: CoreStateMachine::pushState Jan 09 21:54:00 volumio7 volumio[1112]: info: CoreCommandRouter::volumioPushState Jan 09 21:54:00 volumio7 volumio[1112]: info: ------------------------------ 234ms Jan 09 21:54:00 volumio7 volumio[1112]: info: ------------------------------ 229ms Jan 09 21:54:00 volumio7 volumio[1112]: info: ------------------------------ 216ms Jan 09 21:54:35 volumio7 volumio[1112]: info: CoreCommandRouter::volumioGetState Jan 09 21:54:47 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 09 21:54:47 volumio7 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 09 21:54:54 volumio7 sudo[6489]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Jan 09 21:54:54 volumio7 sudo[6489]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 21:54:54 volumio7 sudo[6491]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Jan 09 21:54:54 volumio7 sudo[6489]: pam_unix(sudo:session): session closed for user root Jan 09 21:54:54 volumio7 sudo[6491]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 21:54:54 volumio7 volumio[1112]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Jan 09 21:54:54 volumio7 volumio[1112]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 21:54:54 volumio7 sudo[6493]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Jan 09 21:54:54 volumio7 sudo[6493]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 21:54:54 volumio7 volumio[1112]: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 21:54:54 volumio7 volumio[1112]: at /data/plugins/user_interface/touch_display/index.js:1298:37 Jan 09 21:54:54 volumio7 volumio[1112]: at ChildProcess.exithandler (node:child_process:413:7) Jan 09 21:54:54 volumio7 volumio[1112]: at ChildProcess.emit (node:events:514:28) Jan 09 21:54:54 volumio7 volumio[1112]: at maybeClose (node:internal/child_process:1105:16) Jan 09 21:54:54 volumio7 volumio[1112]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) Jan 09 21:54:54 volumio7 volumio[1112]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 21:54:54 volumio7 sudo[6496]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Jan 09 21:54:54 volumio7 sudo[6496]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 21:54:54 volumio7 systemd[1]: Reloading. Jan 09 21:54:56 volumio7 sudo[6533]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 21:53' Jan 09 21:54:56 volumio7 sudo[6533]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"