-- Logs begin at Sun 2020-08-02 21:36:23 UTC, end at Wed 2025-03-19 13:45:35 UTC. -- Mar 19 13:44:00 volumio volumio[4985]: info: Mar 19 13:44:00 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:00 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:00 volumio volumio[4985]: info: Mar 19 13:44:00 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:44:00 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:44:00 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:44:00 volumio volumio[4985]: info: ------------------------------ 6ms Mar 19 13:44:00 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:44:00 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:44:00 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:44:00 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:44:00 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:44:00 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:44:00 volumio volumio[4985]: info: CorePlayQueue::getTrack 17 Mar 19 13:44:00 volumio volumio[4985]: info: CorePlayQueue::getTrack 17 Mar 19 13:44:00 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Canis Major","artist":null,"album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/CanisMajor.ogg","trackType":"ogg"} Mar 19 13:44:00 volumio volumio[4985]: verbose: CURRENT POSITION 17 Mar 19 13:44:00 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:44:00 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:44:00 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:44:00 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:00 volumio volumio[4985]: info: CorePlayQueue::getTrack 17 Mar 19 13:44:00 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:00 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:00 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:00 volumio volumio[4985]: info: CorePlayQueue::getTrack 17 Mar 19 13:44:00 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:00 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:00 volumio volumio[4985]: info: ------------------------------ 37ms Mar 19 13:44:00 volumio volumio[4985]: info: CorePlayQueue::getTrack 17 Mar 19 13:44:00 volumio volumio[4985]: info: CorePlayQueue::getTrack 18 Mar 19 13:44:00 volumio volumio[4985]: info: Prefetching next song Mar 19 13:44:00 volumio volumio[4985]: info: DOING PREFETCH IN MPD Mar 19 13:44:00 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Club_Cubano.ogg" Mar 19 13:44:00 volumio volumio[4985]: info: Mar 19 13:44:00 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:00 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:00 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 19 13:44:00 volumio volumio[4985]: info: ------------------------------ 10ms Mar 19 13:44:03 volumio volumio[4985]: info: Mar 19 13:44:03 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:03 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:03 volumio volumio[4985]: info: Mar 19 13:44:03 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:44:03 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:44:03 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:44:03 volumio volumio[4985]: info: ------------------------------ 6ms Mar 19 13:44:03 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:44:03 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:44:03 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:44:03 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:44:03 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:44:03 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:44:03 volumio volumio[4985]: info: CorePlayQueue::getTrack 18 Mar 19 13:44:03 volumio volumio[4985]: info: CorePlayQueue::getTrack 18 Mar 19 13:44:03 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Caribbean Ice","artist":"Dr. MAD","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/CaribbeanIce.ogg","trackType":"ogg"} Mar 19 13:44:03 volumio volumio[4985]: verbose: CURRENT POSITION 18 Mar 19 13:44:03 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:44:03 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:44:03 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:44:03 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:03 volumio volumio[4985]: info: CorePlayQueue::getTrack 18 Mar 19 13:44:03 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:03 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:03 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:03 volumio volumio[4985]: info: CorePlayQueue::getTrack 18 Mar 19 13:44:03 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:03 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:03 volumio volumio[4985]: info: ------------------------------ 28ms Mar 19 13:44:03 volumio volumio[4985]: info: CorePlayQueue::getTrack 18 Mar 19 13:44:03 volumio volumio[4985]: info: CorePlayQueue::getTrack 19 Mar 19 13:44:03 volumio volumio[4985]: info: Prefetching next song Mar 19 13:44:03 volumio volumio[4985]: info: DOING PREFETCH IN MPD Mar 19 13:44:03 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/CrayonRock.ogg" Mar 19 13:44:03 volumio volumio[4985]: info: Mar 19 13:44:03 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:03 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:03 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 19 13:44:03 volumio volumio[4985]: info: ------------------------------ 10ms Mar 19 13:44:07 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:44:07 volumio volumio[4985]: info: CorePlayQueue::getTrack 19 Mar 19 13:44:07 volumio volumio[4985]: info: CorePlayQueue::getTrack 19 Mar 19 13:44:07 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:07 volumio volumio[4985]: info: Prefetching next song Mar 19 13:44:07 volumio volumio[4985]: info: DOING PREFETCH IN MPD Mar 19 13:44:07 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/CrazyDream.ogg" Mar 19 13:44:07 volumio volumio[4985]: info: Mar 19 13:44:07 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:07 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:07 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 19 13:44:07 volumio volumio[4985]: info: ------------------------------ 4ms Mar 19 13:44:07 volumio volumio[4985]: info: Mar 19 13:44:07 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:07 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:07 volumio volumio[4985]: info: Mar 19 13:44:07 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:44:07 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:44:07 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:44:07 volumio volumio[4985]: info: ------------------------------ 5ms Mar 19 13:44:07 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:44:07 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:44:07 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:44:07 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:44:07 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:44:07 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:44:07 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:07 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:07 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":3,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Carina","artist":null,"album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Carina.ogg","trackType":"ogg"} Mar 19 13:44:07 volumio volumio[4985]: verbose: CURRENT POSITION 20 Mar 19 13:44:07 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:44:07 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:44:07 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:44:07 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:07 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:07 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:07 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:07 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:07 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:07 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:07 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:07 volumio volumio[4985]: info: ------------------------------ 29ms Mar 19 13:44:10 volumio volumio[4985]: info: Mar 19 13:44:10 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:10 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:10 volumio volumio[4985]: info: Mar 19 13:44:10 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:44:10 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:44:10 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:44:10 volumio volumio[4985]: info: ------------------------------ 6ms Mar 19 13:44:10 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:44:10 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:44:10 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:44:10 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:44:10 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:44:10 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:10 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Centaurus","artist":null,"album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Centaurus.ogg","trackType":"ogg"} Mar 19 13:44:10 volumio volumio[4985]: verbose: CURRENT POSITION 20 Mar 19 13:44:10 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:44:10 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:44:10 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:44:10 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:10 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:10 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:10 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:10 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:10 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:10 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:10 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:10 volumio volumio[4985]: info: ------------------------------ 28ms Mar 19 13:44:14 volumio volumio[4985]: info: Mar 19 13:44:14 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:14 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:14 volumio volumio[4985]: info: Mar 19 13:44:14 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:44:14 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:44:14 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:44:14 volumio volumio[4985]: info: ------------------------------ 9ms Mar 19 13:44:14 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:44:14 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:44:14 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:44:14 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:44:14 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:44:14 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:14 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Champagne Edition","artist":"Dr. Mad","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Champagne_Edition.ogg","trackType":"ogg"} Mar 19 13:44:14 volumio volumio[4985]: verbose: CURRENT POSITION 20 Mar 19 13:44:14 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:44:14 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:44:14 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:44:14 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:14 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:14 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:14 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:14 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:14 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:14 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:14 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:14 volumio volumio[4985]: info: ------------------------------ 35ms Mar 19 13:44:19 volumio volumio[4985]: info: Mar 19 13:44:19 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:19 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:19 volumio volumio[4985]: info: Mar 19 13:44:19 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:44:19 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:44:19 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:44:19 volumio volumio[4985]: info: ------------------------------ 5ms Mar 19 13:44:19 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:44:19 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:44:19 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:44:19 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:44:19 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:44:19 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:19 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":69,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Club Cubano","artist":"Dr. Mad","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Club_Cubano.ogg","trackType":"ogg"} Mar 19 13:44:19 volumio volumio[4985]: verbose: CURRENT POSITION 20 Mar 19 13:44:19 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:44:19 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:44:19 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:44:19 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:19 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:19 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:19 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:19 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:19 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:19 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:19 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:19 volumio volumio[4985]: info: ------------------------------ 32ms Mar 19 13:44:23 volumio volumio[4985]: info: Mar 19 13:44:23 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:23 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:23 volumio volumio[4985]: info: Mar 19 13:44:23 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:44:23 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:44:23 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:44:23 volumio volumio[4985]: info: ------------------------------ 11ms Mar 19 13:44:23 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:44:23 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:44:23 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:44:23 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:44:23 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:23 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":69,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Crayon Rock","artist":"Dr. Mad","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/CrayonRock.ogg","trackType":"ogg"} Mar 19 13:44:23 volumio volumio[4985]: verbose: CURRENT POSITION 20 Mar 19 13:44:23 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:44:23 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:44:23 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:44:23 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:23 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:23 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:23 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:23 volumio volumio[4985]: info: ------------------------------ 36ms Mar 19 13:44:23 volumio volumio[4985]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::volumioGetState Mar 19 13:44:23 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:23 volumio volumio[4985]: info: Restoring Previous Volume level: 15 false false Mar 19 13:44:23 volumio volumio[4985]: info: Volume configurations have been set Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 19 13:44:23 volumio volumio[4985]: info: Updating Volume Controller Parameters: Device: 1 Name: Realtek USB2.0 Audio Mixer: Headphone Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 19 13:44:23 volumio volumio[4985]: info: VolumeController:: Volume=15 Mute =false Mar 19 13:44:23 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:23 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:23 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:26 volumio volumio[4985]: info: Mar 19 13:44:26 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:26 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:26 volumio volumio[4985]: info: Mar 19 13:44:26 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:44:26 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:44:26 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:44:26 volumio volumio[4985]: info: ------------------------------ 4ms Mar 19 13:44:26 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:44:26 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:44:26 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:44:26 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:44:26 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:44:26 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:26 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":31,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Crazy Dream","artist":"Dr. MAD","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/CrazyDream.ogg","trackType":"ogg"} Mar 19 13:44:26 volumio volumio[4985]: verbose: CURRENT POSITION 20 Mar 19 13:44:26 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:44:26 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:44:26 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:44:26 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:26 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:26 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:26 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:26 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:26 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:26 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:26 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:26 volumio volumio[4985]: info: ------------------------------ 24ms Mar 19 13:44:27 volumio volumio[4985]: info: VolumeController::SetAlsaVolume15 Mar 19 13:44:27 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:27 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:27 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:27 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:36 volumio volumio[4985]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 19 13:44:36 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Mar 19 13:44:47 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 19 13:44:47 volumio volumio[4985]: info: CURURI: music-library Mar 19 13:44:52 volumio volumio[4985]: info: CorePlayQueue::getTrack 20 Mar 19 13:44:52 volumio volumio[4985]: info: CorePlayQueue::getTrack 21 Mar 19 13:44:52 volumio volumio[4985]: info: Prefetching next song Mar 19 13:44:52 volumio volumio[4985]: info: DOING PREFETCH IN MPD Mar 19 13:44:52 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/CurveBall.ogg" Mar 19 13:44:52 volumio volumio[4985]: info: Mar 19 13:44:52 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:52 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:52 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 19 13:44:52 volumio volumio[4985]: info: ------------------------------ 4ms Mar 19 13:44:54 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 19 13:44:56 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 19 13:44:57 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:44:57 volumio volumio[4985]: info: CorePlayQueue::getTrack 21 Mar 19 13:44:57 volumio volumio[4985]: info: CorePlayQueue::getTrack 21 Mar 19 13:44:57 volumio volumio[4985]: info: CorePlayQueue::getTrack 22 Mar 19 13:44:57 volumio volumio[4985]: info: Prefetching next song Mar 19 13:44:57 volumio volumio[4985]: info: DOING PREFETCH IN MPD Mar 19 13:44:57 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Cygnus.ogg" Mar 19 13:44:57 volumio volumio[4985]: info: Mar 19 13:44:57 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:57 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:57 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 19 13:44:57 volumio volumio[4985]: info: ------------------------------ 4ms Mar 19 13:44:57 volumio volumio[4985]: info: Mar 19 13:44:57 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:57 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:57 volumio volumio[4985]: info: Mar 19 13:44:57 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:44:57 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:44:57 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:44:57 volumio volumio[4985]: info: ------------------------------ 10ms Mar 19 13:44:57 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:44:57 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:44:57 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:44:57 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:44:57 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:44:57 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:44:57 volumio volumio[4985]: info: CorePlayQueue::getTrack 22 Mar 19 13:44:57 volumio volumio[4985]: info: CorePlayQueue::getTrack 22 Mar 19 13:44:57 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Curve Ball Blend","artist":"Dr. MAD","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/CurveBall.ogg","trackType":"ogg"} Mar 19 13:44:57 volumio volumio[4985]: verbose: CURRENT POSITION 22 Mar 19 13:44:57 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:44:57 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:44:57 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:44:57 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:57 volumio volumio[4985]: info: CorePlayQueue::getTrack 22 Mar 19 13:44:57 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:57 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:57 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:44:57 volumio volumio[4985]: info: CorePlayQueue::getTrack 22 Mar 19 13:44:57 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:44:57 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:44:57 volumio volumio[4985]: info: ------------------------------ 32ms Mar 19 13:44:58 volumio volumio[4985]: info: CorePlayQueue::getTrack 22 Mar 19 13:44:58 volumio volumio[4985]: info: CorePlayQueue::getTrack 23 Mar 19 13:44:58 volumio volumio[4985]: info: Prefetching next song Mar 19 13:44:58 volumio volumio[4985]: info: DOING PREFETCH IN MPD Mar 19 13:44:58 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/DancinFool.ogg" Mar 19 13:44:58 volumio volumio[4985]: info: Mar 19 13:44:58 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:44:58 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:44:58 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 19 13:44:58 volumio volumio[4985]: info: ------------------------------ 3ms Mar 19 13:45:01 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:45:01 volumio volumio[4985]: info: CorePlayQueue::getTrack 23 Mar 19 13:45:01 volumio volumio[4985]: info: Mar 19 13:45:01 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:01 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:01 volumio volumio[4985]: info: Mar 19 13:45:01 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:01 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:01 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:01 volumio volumio[4985]: info: ------------------------------ 6ms Mar 19 13:45:01 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:01 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:01 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:01 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:01 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:01 volumio volumio[4985]: info: CorePlayQueue::getTrack 23 Mar 19 13:45:01 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Cygnus","artist":null,"album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Cygnus.ogg","trackType":"ogg"} Mar 19 13:45:01 volumio volumio[4985]: verbose: CURRENT POSITION 23 Mar 19 13:45:01 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:01 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:45:01 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:45:01 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:01 volumio volumio[4985]: info: CorePlayQueue::getTrack 23 Mar 19 13:45:01 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:01 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:01 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:01 volumio volumio[4985]: info: CorePlayQueue::getTrack 23 Mar 19 13:45:01 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:01 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:01 volumio volumio[4985]: info: ------------------------------ 29ms Mar 19 13:45:02 volumio volumio[4985]: info: CoreCommandRouter::volumioAddQueueItems Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::addQueueItems Mar 19 13:45:02 volumio volumio[4985]: info: CorePlayQueue::addQueueItems Mar 19 13:45:02 volumio volumio[4985]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1773670 Mar 19 13:45:02 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 19 13:45:02 volumio volumio[4985]: info: CorePlayQueue::saveQueue Mar 19 13:45:02 volumio volumio[4985]: info: CoreCommandRouter::volumioPushQueue Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::updateTrackBlock Mar 19 13:45:02 volumio volumio[4985]: info: CorePlayQueue::getTrackBlock Mar 19 13:45:02 volumio volumio[4985]: info: CoreCommandRouter::volumioPlay Mar 19 13:45:02 volumio volumio[4985]: UNSET VOLATILE Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::play index 102 Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::stop Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:02 volumio volumio[4985]: UNSET VOLATILE Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::stPlaybackTimer Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::updateTrackBlock Mar 19 13:45:02 volumio volumio[4985]: info: CorePlayQueue::getTrackBlock Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:02 volumio volumio[4985]: info: CorePlayQueue::getTrack 23 Mar 19 13:45:02 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:02 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::serviceStop Mar 19 13:45:02 volumio volumio[4985]: info: CorePlayQueue::getTrack 23 Mar 19 13:45:02 volumio volumio[4985]: info: CoreCommandRouter::serviceStop Mar 19 13:45:02 volumio volumio[4985]: info: ControllerMpd::stop Mar 19 13:45:02 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 13:45:02 volumio volumio[4985]: info: Mar 19 13:45:02 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:02 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:02 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::play index undefined Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:02 volumio volumio[4985]: info: CorePlayQueue::getTrack 102 Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:45:02 volumio volumio[4985]: info: CorePlayQueue::getTrack 102 Mar 19 13:45:02 volumio volumio[4985]: info: [1742391902611] ControllerWebradio::clearAddPlayTrack Mar 19 13:45:02 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 13:45:02 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:02 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:02 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand clear Mar 19 13:45:02 volumio volumio[4985]: info: Mar 19 13:45:02 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:02 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:02 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:02 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1773670" Mar 19 13:45:02 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:02 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:02 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:02 volumio volumio[4985]: info: CorePlayQueue::getTrack 102 Mar 19 13:45:02 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:02 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:02 volumio volumio[4985]: info: CorePlayQueue::getTrack 102 Mar 19 13:45:02 volumio volumio[4985]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 19 13:45:02 volumio volumio[4985]: info: ------------------------------ 31ms Mar 19 13:45:02 volumio volumio[4985]: error: updateQueue error: null Mar 19 13:45:02 volumio volumio[4985]: info: ------------------------------ 17ms Mar 19 13:45:03 volumio volumio[4985]: info: Mar 19 13:45:03 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:03 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:03 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 19 13:45:03 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand play Mar 19 13:45:03 volumio volumio[4985]: info: ------------------------------ 8ms Mar 19 13:45:04 volumio volumio[4985]: info: Mar 19 13:45:04 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:04 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:04 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:04 volumio volumio[4985]: info: Mar 19 13:45:04 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:04 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:04 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:04 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:04 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:04 volumio volumio[4985]: info: Mar 19 13:45:04 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:04 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:04 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:04 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:04 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:04 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:04 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:04 volumio volumio[4985]: info: CorePlayQueue::getTrack 102 Mar 19 13:45:04 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"46 Kbps","isStreaming":false,"title":"stream","artist":"Focus FM Regional","album":null,"uri":"http://89.40.72.71:8000/stream","trackType":""} Mar 19 13:45:04 volumio volumio[4985]: verbose: CURRENT POSITION 102 Mar 19 13:45:04 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:04 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus stop Mar 19 13:45:04 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:04 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:04 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:04 volumio volumio[4985]: info: ------------------------------ 50ms Mar 19 13:45:04 volumio volumio[4985]: info: ------------------------------ 19ms Mar 19 13:45:04 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:04 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:04 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:04 volumio volumio[4985]: info: CorePlayQueue::getTrack 102 Mar 19 13:45:04 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"54 Kbps","isStreaming":false,"title":"stream","artist":"Focus FM Regional","album":null,"uri":"http://89.40.72.71:8000/stream","trackType":""} Mar 19 13:45:04 volumio volumio[4985]: verbose: CURRENT POSITION 102 Mar 19 13:45:04 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:04 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:45:04 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:45:04 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:04 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:04 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:04 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:04 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:04 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:04 volumio volumio[4985]: info: ------------------------------ 42ms Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::volumioPlay Mar 19 13:45:22 volumio volumio[4985]: UNSET VOLATILE Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::play index 4 Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::stop Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:22 volumio volumio[4985]: UNSET VOLATILE Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::stPlaybackTimer Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::updateTrackBlock Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrackBlock Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 102 Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::serviceStop Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 102 Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::serviceStop Mar 19 13:45:22 volumio volumio[4985]: info: [1742391922140] ControllerWebradio::stop Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 13:45:22 volumio volumio[4985]: info: Mar 19 13:45:22 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:22 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::play index undefined Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::clearAddPlayTracks USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Backroad.ogg Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand clear Mar 19 13:45:22 volumio volumio[4985]: info: Mar 19 13:45:22 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:22 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Backroad.ogg" Mar 19 13:45:22 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"Focus FM Regional","album":null,"uri":"http://89.40.72.71:8000/stream","trackType":""} Mar 19 13:45:22 volumio volumio[4985]: verbose: CURRENT POSITION 4 Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::syncState stateService stop Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus stop Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:22 volumio volumio[4985]: info: No code Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:22 volumio volumio[4985]: info: ------------------------------ 41ms Mar 19 13:45:22 volumio volumio[4985]: error: updateQueue error: null Mar 19 13:45:22 volumio volumio[4985]: info: Mar 19 13:45:22 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:22 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:22 volumio volumio[4985]: info: ------------------------------ 29ms Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand play Mar 19 13:45:22 volumio volumio[4985]: info: Mar 19 13:45:22 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:22 volumio volumio[4985]: info: ------------------------------ 26ms Mar 19 13:45:22 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:22 volumio volumio[4985]: info: Mar 19 13:45:22 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:22 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:22 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Backroad","artist":"Dr. Mad","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Backroad.ogg","trackType":"ogg"} Mar 19 13:45:22 volumio volumio[4985]: verbose: CURRENT POSITION 4 Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus stop Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:22 volumio volumio[4985]: info: ------------------------------ 38ms Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:22 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Backroad","artist":"Dr. Mad","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Backroad.ogg","trackType":"ogg"} Mar 19 13:45:22 volumio volumio[4985]: verbose: CURRENT POSITION 4 Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:45:22 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:22 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:22 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:22 volumio volumio[4985]: info: ------------------------------ 36ms Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:22 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:22 volumio volumio[4985]: info: Prefetching next song Mar 19 13:45:22 volumio volumio[4985]: info: DOING PREFETCH IN MPD Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BeatPlucker.ogg" Mar 19 13:45:22 volumio volumio[4985]: info: Mar 19 13:45:22 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:22 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:22 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 19 13:45:22 volumio volumio[4985]: info: ------------------------------ 6ms Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::volumioPlay Mar 19 13:45:24 volumio volumio[4985]: UNSET VOLATILE Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::play index 5 Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::stop Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:24 volumio volumio[4985]: UNSET VOLATILE Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::stPlaybackTimer Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::updateTrackBlock Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrackBlock Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::serviceStop Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 4 Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::serviceStop Mar 19 13:45:24 volumio volumio[4985]: info: ControllerMpd::stop Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 13:45:24 volumio volumio[4985]: info: Mar 19 13:45:24 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:24 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::play index undefined Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::clearAddPlayTracks USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BeatPlucker.ogg Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand clear Mar 19 13:45:24 volumio volumio[4985]: info: Mar 19 13:45:24 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:24 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BeatPlucker.ogg" Mar 19 13:45:24 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: 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":"Backroad","artist":"Dr. Mad","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Backroad.ogg","trackType":"ogg"} Mar 19 13:45:24 volumio volumio[4985]: verbose: CURRENT POSITION 5 Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::syncState stateService stop Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus stop Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:24 volumio volumio[4985]: info: No code Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:24 volumio volumio[4985]: info: ------------------------------ 43ms Mar 19 13:45:24 volumio volumio[4985]: error: updateQueue error: null Mar 19 13:45:24 volumio volumio[4985]: info: Mar 19 13:45:24 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:24 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:24 volumio volumio[4985]: info: ------------------------------ 28ms Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand play Mar 19 13:45:24 volumio volumio[4985]: info: Mar 19 13:45:24 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:24 volumio volumio[4985]: info: ------------------------------ 23ms Mar 19 13:45:24 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:24 volumio volumio[4985]: info: Mar 19 13:45:24 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:24 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:24 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beat Plucker","artist":"Dr. MAD","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BeatPlucker.ogg","trackType":"ogg"} Mar 19 13:45:24 volumio volumio[4985]: verbose: CURRENT POSITION 5 Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus stop Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:24 volumio volumio[4985]: info: ------------------------------ 60ms Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:24 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beat Plucker","artist":"Dr. MAD","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BeatPlucker.ogg","trackType":"ogg"} Mar 19 13:45:24 volumio volumio[4985]: verbose: CURRENT POSITION 5 Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:45:24 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:24 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:24 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:24 volumio volumio[4985]: info: ------------------------------ 78ms Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:24 volumio volumio[4985]: info: CorePlayQueue::getTrack 6 Mar 19 13:45:24 volumio volumio[4985]: info: Prefetching next song Mar 19 13:45:24 volumio volumio[4985]: info: DOING PREFETCH IN MPD Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BentleyDubs.ogg" Mar 19 13:45:24 volumio volumio[4985]: info: Mar 19 13:45:24 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:24 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:24 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 19 13:45:24 volumio volumio[4985]: info: ------------------------------ 7ms Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::volumioPlay Mar 19 13:45:25 volumio volumio[4985]: UNSET VOLATILE Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::play index 6 Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::stop Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:25 volumio volumio[4985]: UNSET VOLATILE Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::stPlaybackTimer Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::updateTrackBlock Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrackBlock Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::serviceStop Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 5 Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::serviceStop Mar 19 13:45:25 volumio volumio[4985]: info: ControllerMpd::stop Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 13:45:25 volumio volumio[4985]: info: Mar 19 13:45:25 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:25 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::play index undefined Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 6 Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 6 Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::clearAddPlayTracks USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BentleyDubs.ogg Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand clear Mar 19 13:45:25 volumio volumio[4985]: info: Mar 19 13:45:25 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:25 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BentleyDubs.ogg" Mar 19 13:45:25 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 6 Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 6 Mar 19 13:45:25 volumio volumio[4985]: 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":"Beat Plucker","artist":"Dr. MAD","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BeatPlucker.ogg","trackType":"ogg"} Mar 19 13:45:25 volumio volumio[4985]: verbose: CURRENT POSITION 6 Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::syncState stateService stop Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus stop Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 6 Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:25 volumio volumio[4985]: info: No code Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 6 Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:25 volumio volumio[4985]: info: ------------------------------ 41ms Mar 19 13:45:25 volumio volumio[4985]: error: updateQueue error: null Mar 19 13:45:25 volumio volumio[4985]: info: Mar 19 13:45:25 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:25 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:25 volumio volumio[4985]: info: ------------------------------ 29ms Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand play Mar 19 13:45:25 volumio volumio[4985]: info: ------------------------------ 14ms Mar 19 13:45:25 volumio volumio[4985]: info: Mar 19 13:45:25 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:25 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 6 Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 7 Mar 19 13:45:25 volumio volumio[4985]: info: Prefetching next song Mar 19 13:45:25 volumio volumio[4985]: info: DOING PREFETCH IN MPD Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Big_Easy.ogg" Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:25 volumio volumio[4985]: info: Mar 19 13:45:25 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:25 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 19 13:45:25 volumio volumio[4985]: info: Mar 19 13:45:25 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:25 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:25 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 7 Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 7 Mar 19 13:45:25 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bentley Dubs","artist":"Dr. MAD","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BentleyDubs.ogg","trackType":"ogg"} Mar 19 13:45:25 volumio volumio[4985]: verbose: CURRENT POSITION 7 Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus stop Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 7 Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:25 volumio volumio[4985]: info: ------------------------------ 49ms Mar 19 13:45:25 volumio volumio[4985]: info: ------------------------------ 17ms Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:25 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 7 Mar 19 13:45:25 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":4,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bentley Dubs","artist":"Dr. MAD","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BentleyDubs.ogg","trackType":"ogg"} Mar 19 13:45:25 volumio volumio[4985]: verbose: CURRENT POSITION 7 Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:45:25 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 7 Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:25 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 7 Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:25 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:25 volumio volumio[4985]: info: ------------------------------ 40ms Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 7 Mar 19 13:45:25 volumio volumio[4985]: info: CorePlayQueue::getTrack 8 Mar 19 13:45:25 volumio volumio[4985]: info: Prefetching next song Mar 19 13:45:25 volumio volumio[4985]: info: DOING PREFETCH IN MPD Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/BirdLoop.ogg" Mar 19 13:45:25 volumio volumio[4985]: info: Mar 19 13:45:25 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:25 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:25 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 19 13:45:25 volumio volumio[4985]: info: ------------------------------ 3ms Mar 19 13:45:29 volumio volumio[4985]: info: Mar 19 13:45:29 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:29 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:29 volumio volumio[4985]: info: Mar 19 13:45:29 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:29 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:29 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:29 volumio volumio[4985]: info: ------------------------------ 5ms Mar 19 13:45:29 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:29 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:29 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:29 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:29 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:29 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:45:29 volumio volumio[4985]: info: CorePlayQueue::getTrack 8 Mar 19 13:45:29 volumio volumio[4985]: info: CorePlayQueue::getTrack 8 Mar 19 13:45:29 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":5,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Big Easy","artist":"Dr. Mad","album":null,"uri":"USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Big_Easy.ogg","trackType":"ogg"} Mar 19 13:45:29 volumio volumio[4985]: verbose: CURRENT POSITION 8 Mar 19 13:45:29 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:29 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:45:29 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:45:29 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:29 volumio volumio[4985]: info: CorePlayQueue::getTrack 8 Mar 19 13:45:29 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:29 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:29 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:29 volumio volumio[4985]: info: CorePlayQueue::getTrack 8 Mar 19 13:45:29 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:29 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:29 volumio volumio[4985]: info: ------------------------------ 27ms Mar 19 13:45:30 volumio volumio[4985]: info: CorePlayQueue::getTrack 8 Mar 19 13:45:30 volumio volumio[4985]: info: CorePlayQueue::getTrack 9 Mar 19 13:45:30 volumio volumio[4985]: info: Prefetching next song Mar 19 13:45:30 volumio volumio[4985]: info: DOING PREFETCH IN MPD Mar 19 13:45:30 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand add "USB/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_/media/audio/ringtones/Bollywood.ogg" Mar 19 13:45:30 volumio volumio[4985]: info: Mar 19 13:45:30 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:30 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:30 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 19 13:45:30 volumio volumio[4985]: info: ------------------------------ 4ms Mar 19 13:45:32 volumio volumio[4985]: info: CoreCommandRouter::volumioAddQueueItems Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::addQueueItems Mar 19 13:45:32 volumio volumio[4985]: info: CorePlayQueue::addQueueItems Mar 19 13:45:32 volumio volumio[4985]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1885897 Mar 19 13:45:32 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 19 13:45:32 volumio volumio[4985]: info: CorePlayQueue::saveQueue Mar 19 13:45:32 volumio volumio[4985]: info: CoreCommandRouter::volumioPushQueue Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::updateTrackBlock Mar 19 13:45:32 volumio volumio[4985]: info: CorePlayQueue::getTrackBlock Mar 19 13:45:32 volumio volumio[4985]: info: CoreCommandRouter::volumioPlay Mar 19 13:45:32 volumio volumio[4985]: UNSET VOLATILE Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::play index 103 Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::stop Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:32 volumio volumio[4985]: UNSET VOLATILE Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::stPlaybackTimer Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::updateTrackBlock Mar 19 13:45:32 volumio volumio[4985]: info: CorePlayQueue::getTrackBlock Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:32 volumio volumio[4985]: info: CorePlayQueue::getTrack 8 Mar 19 13:45:32 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:32 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::serviceStop Mar 19 13:45:32 volumio volumio[4985]: info: CorePlayQueue::getTrack 8 Mar 19 13:45:32 volumio volumio[4985]: info: CoreCommandRouter::serviceStop Mar 19 13:45:32 volumio volumio[4985]: info: ControllerMpd::stop Mar 19 13:45:32 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 13:45:32 volumio volumio[4985]: info: Mar 19 13:45:32 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:32 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:32 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::play index undefined Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:45:32 volumio volumio[4985]: info: CorePlayQueue::getTrack 103 Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:45:32 volumio volumio[4985]: info: CorePlayQueue::getTrack 103 Mar 19 13:45:32 volumio volumio[4985]: info: [1742391932818] ControllerWebradio::clearAddPlayTrack Mar 19 13:45:32 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 13:45:32 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:32 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:32 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand clear Mar 19 13:45:32 volumio volumio[4985]: info: Mar 19 13:45:32 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:32 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:32 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:32 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1885897" Mar 19 13:45:32 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:32 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:32 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:32 volumio volumio[4985]: info: CorePlayQueue::getTrack 103 Mar 19 13:45:32 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:32 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:32 volumio volumio[4985]: info: CorePlayQueue::getTrack 103 Mar 19 13:45:32 volumio volumio[4985]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 19 13:45:32 volumio volumio[4985]: info: ------------------------------ 30ms Mar 19 13:45:32 volumio volumio[4985]: error: updateQueue error: null Mar 19 13:45:32 volumio volumio[4985]: info: ------------------------------ 17ms Mar 19 13:45:33 volumio volumio[4985]: info: Mar 19 13:45:33 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:33 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:33 volumio volumio[4985]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 19 13:45:33 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand play Mar 19 13:45:33 volumio volumio[4985]: info: ------------------------------ 8ms Mar 19 13:45:33 volumio volumio[4985]: info: Mar 19 13:45:33 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:33 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:33 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:33 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:33 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:33 volumio volumio[4985]: info: Mar 19 13:45:33 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:33 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:33 volumio volumio[4985]: info: Mar 19 13:45:33 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:33 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:33 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:33 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:33 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:33 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:33 volumio volumio[4985]: info: CorePlayQueue::getTrack 103 Mar 19 13:45:33 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"98satRN","album":null,"uri":"http://45.225.80.20:8010/stream","trackType":""} Mar 19 13:45:33 volumio volumio[4985]: verbose: CURRENT POSITION 103 Mar 19 13:45:33 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:33 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus stop Mar 19 13:45:33 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:33 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:33 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:33 volumio volumio[4985]: info: ------------------------------ 39ms Mar 19 13:45:33 volumio volumio[4985]: info: ------------------------------ 15ms Mar 19 13:45:33 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:33 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:33 volumio volumio[4985]: info: Mar 19 13:45:33 volumio volumio[4985]: ---------------------------- MPD announces system playlist update Mar 19 13:45:34 volumio volumio[4985]: info: Ignoring MPD Status Update Mar 19 13:45:34 volumio volumio[4985]: info: Mar 19 13:45:34 volumio volumio[4985]: ---------------------------- MPD announces state update: player Mar 19 13:45:34 volumio volumio[4985]: info: ControllerMpd::getState Mar 19 13:45:34 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:45:34 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:34 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:34 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:34 volumio volumio[4985]: info: CorePlayQueue::getTrack 103 Mar 19 13:45:34 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"98satRN","album":null,"uri":"http://45.225.80.20:8010/stream","trackType":""} Mar 19 13:45:34 volumio volumio[4985]: verbose: CURRENT POSITION 103 Mar 19 13:45:34 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:34 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:45:34 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:45:34 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:34 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:34 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:34 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:34 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:34 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:34 volumio volumio[4985]: info: ------------------------------ 41ms Mar 19 13:45:34 volumio volumio[4985]: info: ------------------------------ 23ms Mar 19 13:45:34 volumio volumio[4985]: verbose: ControllerMpd::parseState Mar 19 13:45:34 volumio volumio[4985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:45:34 volumio volumio[4985]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:45:34 volumio volumio[4985]: info: ControllerMpd::pushState Mar 19 13:45:34 volumio volumio[4985]: info: CoreCommandRouter::servicePushState Mar 19 13:45:34 volumio volumio[4985]: info: CorePlayQueue::getTrack 103 Mar 19 13:45:34 volumio volumio[4985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"29 Kbps","isStreaming":false,"title":"Hi-Fi Internet Stream","artist":"98satRN","album":null,"uri":"http://45.225.80.20:8010/stream","trackType":""} Mar 19 13:45:34 volumio volumio[4985]: verbose: CURRENT POSITION 103 Mar 19 13:45:34 volumio volumio[4985]: info: CoreStateMachine::syncState stateService play Mar 19 13:45:34 volumio volumio[4985]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:45:34 volumio volumio[4985]: info: Received an update from plugin. extracting info from payload Mar 19 13:45:34 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:34 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:34 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:34 volumio volumio[4985]: info: CoreStateMachine::pushState Mar 19 13:45:34 volumio volumio[4985]: info: CoreCommandRouter::volumioPushState Mar 19 13:45:34 volumio volumio[4985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:45:34 volumio volumio[4985]: info: ------------------------------ 48ms Mar 19 13:45:35 volumio volumio[4985]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 19 13:45:35 volumio volumio[4985]: { Error: connect ETIMEDOUT 69.63.184.30:80 Mar 19 13:45:35 volumio volumio[4985]: at Object._errnoException (util.js:1022:11) Mar 19 13:45:35 volumio volumio[4985]: at _exceptionWithHostPort (util.js:1044:20) Mar 19 13:45:35 volumio volumio[4985]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Mar 19 13:45:35 volumio volumio[4985]: code: 'ETIMEDOUT', Mar 19 13:45:35 volumio volumio[4985]: errno: 'ETIMEDOUT', Mar 19 13:45:35 volumio volumio[4985]: syscall: 'connect', Mar 19 13:45:35 volumio volumio[4985]: address: '69.63.184.30', Mar 19 13:45:35 volumio volumio[4985]: port: 80 } Mar 19 13:45:35 volumio volumio[4985]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 19 13:45:35 volumio sudo[6413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-19 13:44 Mar 19 13:45:35 volumio sudo[6413]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="493b3f2063c664b52681092d76718ef5fb070910" VOLUMIO_FE_VERSION="4917998f86709e30d6499627aa39df0350cb55f8" VOLUMIO_BE_VERSION="d9435b7a968fdb32f8774ce87d86f5f44a90fb66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun Aug 2 23:36:23 CEST 2020" VOLUMIO_VERSION="2.806" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="721ce12033fe994c37bd358dd68cf9f9"