-- Logs begin at Sun 2025-04-27 08:25:27 UTC, end at Sun 2025-04-27 09:26:43 UTC. -- Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::volumioNext Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::next Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::stop Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 6 Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::serviceStop Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 6 Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::serviceStop Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::stop Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand stop took 8 milliseconds Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::play index undefined Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::startPlaybackTimer Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand status took 3 milliseconds Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand stop took 3 milliseconds Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand status took 2 milliseconds Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:00 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand clear took 3 milliseconds Apr 27 09:25:00 volumio volumio[3249]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 7ms Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 7ms Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 7ms Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: verbose: STATE SERVICE {"status":"stop","position":8,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Yes, I'm Your Angel","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:00 volumio volumio[3249]: verbose: CURRENT POSITION 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::syncState stateService stop Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:00 volumio volumio[3249]: info: No code Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 18ms Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:00 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:00 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:00 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:00 volumio volumio[3249]: error: updateQueue error: null Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:00 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 23ms Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" took 22 milliseconds Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 11ms Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 10ms Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 8ms Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand play Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:00 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:00 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:00 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 39ms Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand play took 40 milliseconds Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 40ms Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 39ms Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:00 volumio volumio[3249]: info: Apr 27 09:25:00 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:00 volumio volumio[3249]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 27 09:25:00 volumio volumio[3249]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 27 09:25:00 volumio volumio[3249]: error: FusionDsp - File size not found in array! Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand status took 4 milliseconds Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand status took 6 milliseconds Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand status took 5 milliseconds Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:00 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 27 09:25:00 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":7,"seek":958,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"652 Kbps","isStreaming":false,"title":"Watching The Wheels","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:00 volumio volumio[3249]: verbose: CURRENT POSITION 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":7,"seek":958,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"652 Kbps","isStreaming":false,"title":"Watching The Wheels","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:00 volumio volumio[3249]: verbose: CURRENT POSITION 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:25:00 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":7,"seek":958,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"652 Kbps","isStreaming":false,"title":"Watching The Wheels","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:00 volumio volumio[3249]: verbose: CURRENT POSITION 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:25:00 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:00 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":7,"seek":958,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"652 Kbps","isStreaming":false,"title":"Watching The Wheels","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:00 volumio volumio[3249]: verbose: CURRENT POSITION 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:25:00 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:00 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:00 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:00 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 37ms Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 34ms Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 35ms Apr 27 09:25:00 volumio volumio[3249]: info: ------------------------------ 34ms Apr 27 09:25:00 volumio volumio[3249]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 27 09:25:00 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:00 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1974. Apr 27 09:25:00 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:00 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:00 volumio volumio[8008]: Traceback (most recent call last): Apr 27 09:25:00 volumio volumio[8008]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:00 volumio volumio[8008]: from aiohttp import web Apr 27 09:25:00 volumio volumio[8008]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:00 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:00 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::volumioNext Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::next Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::stop Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::serviceStop Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 7 Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::serviceStop Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::stop Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand stop took 4 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::play index undefined Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::startPlaybackTimer Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand status took 3 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand stop took 3 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand status took 3 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand status took 2 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand status took 1 milliseconds Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:02 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand clear took 2 milliseconds Apr 27 09:25:02 volumio volumio[3249]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 5ms Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 5ms Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 4ms Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: verbose: STATE SERVICE {"status":"stop","position":7,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Watching The Wheels","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:02 volumio volumio[3249]: verbose: CURRENT POSITION 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::syncState stateService stop Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:02 volumio volumio[3249]: info: No code Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 14ms Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:02 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:02 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:02 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:02 volumio volumio[3249]: error: updateQueue error: null Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:02 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 12ms Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" took 11 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 3ms Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 2ms Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand play Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:02 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:02 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:02 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 32ms Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 31ms Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand play took 31 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 30ms Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 35ms Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:02 volumio volumio[3249]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 27 09:25:02 volumio volumio[3249]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 27 09:25:02 volumio volumio[3249]: error: FusionDsp - File size not found in array! Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:02 volumio volumio[3249]: info: Apr 27 09:25:02 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand status took 13 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand status took 8 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand status took 6 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand status took 1 milliseconds Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 27 09:25:02 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 27 09:25:02 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":8,"seek":456,"duration":190,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"477 Kbps","isStreaming":false,"title":"Yes, I'm Your Angel","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:02 volumio volumio[3249]: verbose: CURRENT POSITION 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":8,"seek":456,"duration":190,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"477 Kbps","isStreaming":false,"title":"Yes, I'm Your Angel","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:02 volumio volumio[3249]: verbose: CURRENT POSITION 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:25:02 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":8,"seek":456,"duration":190,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"477 Kbps","isStreaming":false,"title":"Yes, I'm Your Angel","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:02 volumio volumio[3249]: verbose: CURRENT POSITION 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:25:02 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:02 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":8,"seek":456,"duration":190,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"477 Kbps","isStreaming":false,"title":"Yes, I'm Your Angel","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:02 volumio volumio[3249]: verbose: CURRENT POSITION 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:25:02 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:02 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:02 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:02 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 44ms Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 40ms Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 38ms Apr 27 09:25:02 volumio volumio[3249]: info: ------------------------------ 33ms Apr 27 09:25:02 volumio volumio[3249]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 27 09:25:03 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:03 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1975. Apr 27 09:25:03 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:03 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:03 volumio volumio[8013]: Traceback (most recent call last): Apr 27 09:25:03 volumio volumio[8013]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:03 volumio volumio[8013]: from aiohttp import web Apr 27 09:25:03 volumio volumio[8013]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:03 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:03 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:05 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:05 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1976. Apr 27 09:25:05 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:05 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:05 volumio volumio[8014]: Traceback (most recent call last): Apr 27 09:25:05 volumio volumio[8014]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:05 volumio volumio[8014]: from aiohttp import web Apr 27 09:25:05 volumio volumio[8014]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:05 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:05 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:07 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:07 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1977. Apr 27 09:25:07 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:07 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:07 volumio volumio[8015]: Traceback (most recent call last): Apr 27 09:25:07 volumio volumio[8015]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:07 volumio volumio[8015]: from aiohttp import web Apr 27 09:25:07 volumio volumio[8015]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:07 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:07 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::volumioNext Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::next Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::stop Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::serviceStop Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 8 Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::serviceStop Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::stop Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand stop took 12 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::play index undefined Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::startPlaybackTimer Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand status took 5 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand stop took 4 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand status took 4 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand status took 2 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand status took 1 milliseconds Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:08 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand clear took 3 milliseconds Apr 27 09:25:08 volumio volumio[3249]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Apr 27 09:25:08 volumio volumio[3249]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 7ms Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 4ms Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: verbose: STATE SERVICE {"status":"stop","position":8,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Yes, I'm Your Angel","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:08 volumio volumio[3249]: verbose: CURRENT POSITION 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::syncState stateService stop Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:08 volumio volumio[3249]: info: No code Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 16ms Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:08 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:08 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:08 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:08 volumio volumio[3249]: error: updateQueue error: null Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:08 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 17ms Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" took 16 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 8ms Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 6ms Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand play Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:08 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:08 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 18ms Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 16ms Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand play took 15 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 15ms Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:25:08 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:25:08 volumio volumio[3249]: info: FusionDsp - ---- read samplerate, raw: Apr 27 09:25:08 volumio volumio[3249]: error: FusionDsp - invalid sample rate Apr 27 09:25:08 volumio volumio[3249]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 27 09:25:08 volumio volumio[3249]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 27 09:25:08 volumio volumio[3249]: error: FusionDsp - File size not found in array! Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 35ms Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 21ms Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand status took 4 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand status took 1 milliseconds Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:08 volumio volumio[3249]: info: Apr 27 09:25:08 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand status took 1 milliseconds Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand status took 5 milliseconds Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":9,"seek":456,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"720 Kbps","isStreaming":false,"title":"Woman","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:08 volumio volumio[3249]: verbose: CURRENT POSITION 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":9,"seek":456,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"720 Kbps","isStreaming":false,"title":"Woman","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:08 volumio volumio[3249]: verbose: CURRENT POSITION 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:25:08 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":9,"seek":456,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"720 Kbps","isStreaming":false,"title":"Woman","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:08 volumio volumio[3249]: verbose: CURRENT POSITION 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:25:08 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 38ms Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 39ms Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 38ms Apr 27 09:25:08 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 39 milliseconds Apr 27 09:25:08 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:25:08 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":9,"seek":456,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"720 Kbps","isStreaming":false,"title":"Woman","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:25:08 volumio volumio[3249]: verbose: CURRENT POSITION 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:25:08 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:08 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:25:08 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:08 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:25:08 volumio volumio[3249]: info: ------------------------------ 55ms Apr 27 09:25:08 volumio volumio[3249]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 27 09:25:09 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:09 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1978. Apr 27 09:25:09 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:09 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:09 volumio volumio[8018]: Traceback (most recent call last): Apr 27 09:25:09 volumio volumio[8018]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:09 volumio volumio[8018]: from aiohttp import web Apr 27 09:25:09 volumio volumio[8018]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:09 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:09 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:12 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:12 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1979. Apr 27 09:25:12 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:12 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:12 volumio volumio[8019]: Traceback (most recent call last): Apr 27 09:25:12 volumio volumio[8019]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:12 volumio volumio[8019]: from aiohttp import web Apr 27 09:25:12 volumio volumio[8019]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:12 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:12 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:14 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:14 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1980. Apr 27 09:25:14 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:14 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:14 volumio volumio[8020]: Traceback (most recent call last): Apr 27 09:25:14 volumio volumio[8020]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:14 volumio volumio[8020]: from aiohttp import web Apr 27 09:25:14 volumio volumio[8020]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:14 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:14 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:16 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:16 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1981. Apr 27 09:25:16 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:16 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:16 volumio volumio[8021]: Traceback (most recent call last): Apr 27 09:25:16 volumio volumio[8021]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:16 volumio volumio[8021]: from aiohttp import web Apr 27 09:25:16 volumio volumio[8021]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:16 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:16 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:18 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:18 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1982. Apr 27 09:25:18 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:18 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:18 volumio volumio[8022]: Traceback (most recent call last): Apr 27 09:25:18 volumio volumio[8022]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:18 volumio volumio[8022]: from aiohttp import web Apr 27 09:25:18 volumio volumio[8022]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:18 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:18 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:19 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 09:25:19 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 09:25:19 volumio volumio[3249]: info: Discovery: Getting this device information Apr 27 09:25:19 volumio volumio[3249]: info: CoreCommandRouter::volumioGetState Apr 27 09:25:19 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:19 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 09:25:21 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:21 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1983. Apr 27 09:25:21 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:21 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:21 volumio volumio[8024]: Traceback (most recent call last): Apr 27 09:25:21 volumio volumio[8024]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:21 volumio volumio[8024]: from aiohttp import web Apr 27 09:25:21 volumio volumio[8024]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:21 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:21 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:23 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:23 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1984. Apr 27 09:25:23 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:23 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:23 volumio volumio[8025]: Traceback (most recent call last): Apr 27 09:25:23 volumio volumio[8025]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:23 volumio volumio[8025]: from aiohttp import web Apr 27 09:25:23 volumio volumio[8025]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:23 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:23 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:25 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:25 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1985. Apr 27 09:25:25 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:25 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:25 volumio volumio[8027]: Traceback (most recent call last): Apr 27 09:25:25 volumio volumio[8027]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:25 volumio volumio[8027]: from aiohttp import web Apr 27 09:25:25 volumio volumio[8027]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:25 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:25 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:27 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:27 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1986. Apr 27 09:25:27 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:27 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:27 volumio volumio[8028]: Traceback (most recent call last): Apr 27 09:25:27 volumio volumio[8028]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:27 volumio volumio[8028]: from aiohttp import web Apr 27 09:25:27 volumio volumio[8028]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:27 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:27 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:30 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:30 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1987. Apr 27 09:25:30 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:30 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:30 volumio volumio[8030]: Traceback (most recent call last): Apr 27 09:25:30 volumio volumio[8030]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:30 volumio volumio[8030]: from aiohttp import web Apr 27 09:25:30 volumio volumio[8030]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:30 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:30 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:32 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:32 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1988. Apr 27 09:25:32 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:32 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:32 volumio volumio[8077]: Traceback (most recent call last): Apr 27 09:25:32 volumio volumio[8077]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:32 volumio volumio[8077]: from aiohttp import web Apr 27 09:25:32 volumio volumio[8077]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:32 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:32 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:34 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:34 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1989. Apr 27 09:25:34 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:34 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:34 volumio volumio[8080]: Traceback (most recent call last): Apr 27 09:25:34 volumio volumio[8080]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:34 volumio volumio[8080]: from aiohttp import web Apr 27 09:25:34 volumio volumio[8080]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:34 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:34 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:36 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:36 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1990. Apr 27 09:25:36 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:36 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:36 volumio volumio[8081]: Traceback (most recent call last): Apr 27 09:25:36 volumio volumio[8081]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:36 volumio volumio[8081]: from aiohttp import web Apr 27 09:25:36 volumio volumio[8081]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:36 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:36 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:39 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:39 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1991. Apr 27 09:25:39 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:39 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:39 volumio volumio[8082]: Traceback (most recent call last): Apr 27 09:25:39 volumio volumio[8082]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:39 volumio volumio[8082]: from aiohttp import web Apr 27 09:25:39 volumio volumio[8082]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:39 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:39 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:41 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:41 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1992. Apr 27 09:25:41 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:41 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:41 volumio volumio[8083]: Traceback (most recent call last): Apr 27 09:25:41 volumio volumio[8083]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:41 volumio volumio[8083]: from aiohttp import web Apr 27 09:25:41 volumio volumio[8083]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:41 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:41 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:43 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:43 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1993. Apr 27 09:25:43 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:43 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:43 volumio volumio[8084]: Traceback (most recent call last): Apr 27 09:25:43 volumio volumio[8084]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:43 volumio volumio[8084]: from aiohttp import web Apr 27 09:25:43 volumio volumio[8084]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:43 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:43 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:45 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:45 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1994. Apr 27 09:25:45 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:45 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:45 volumio volumio[8086]: Traceback (most recent call last): Apr 27 09:25:45 volumio volumio[8086]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:45 volumio volumio[8086]: from aiohttp import web Apr 27 09:25:45 volumio volumio[8086]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:45 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:45 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:48 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:48 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1995. Apr 27 09:25:48 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:48 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:48 volumio volumio[8087]: Traceback (most recent call last): Apr 27 09:25:48 volumio volumio[8087]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:48 volumio volumio[8087]: from aiohttp import web Apr 27 09:25:48 volumio volumio[8087]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:48 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:48 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:49 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 09:25:49 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 09:25:49 volumio volumio[3249]: info: Discovery: Getting this device information Apr 27 09:25:49 volumio volumio[3249]: info: CoreCommandRouter::volumioGetState Apr 27 09:25:49 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:25:49 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 09:25:50 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:50 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1996. Apr 27 09:25:50 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:50 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:50 volumio volumio[8088]: Traceback (most recent call last): Apr 27 09:25:50 volumio volumio[8088]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:50 volumio volumio[8088]: from aiohttp import web Apr 27 09:25:50 volumio volumio[8088]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:50 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:50 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:52 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:52 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1997. Apr 27 09:25:52 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:52 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:52 volumio volumio[8089]: Traceback (most recent call last): Apr 27 09:25:52 volumio volumio[8089]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:52 volumio volumio[8089]: from aiohttp import web Apr 27 09:25:52 volumio volumio[8089]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:52 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:52 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:54 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:54 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1998. Apr 27 09:25:54 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:54 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:54 volumio volumio[8090]: Traceback (most recent call last): Apr 27 09:25:54 volumio volumio[8090]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:54 volumio volumio[8090]: from aiohttp import web Apr 27 09:25:54 volumio volumio[8090]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:54 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:54 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:57 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:57 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1999. Apr 27 09:25:57 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:57 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:57 volumio volumio[8091]: Traceback (most recent call last): Apr 27 09:25:57 volumio volumio[8091]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:57 volumio volumio[8091]: from aiohttp import web Apr 27 09:25:57 volumio volumio[8091]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:57 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:57 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:25:59 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:25:59 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2000. Apr 27 09:25:59 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:25:59 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:25:59 volumio volumio[8092]: Traceback (most recent call last): Apr 27 09:25:59 volumio volumio[8092]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:25:59 volumio volumio[8092]: from aiohttp import web Apr 27 09:25:59 volumio volumio[8092]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:25:59 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:25:59 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:01 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:01 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2001. Apr 27 09:26:01 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:01 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:01 volumio volumio[8093]: Traceback (most recent call last): Apr 27 09:26:01 volumio volumio[8093]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:01 volumio volumio[8093]: from aiohttp import web Apr 27 09:26:01 volumio volumio[8093]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:01 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:01 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioNext Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::next Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::stop Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::serviceStop Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 9 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::serviceStop Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::stop Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand stop took 5 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::play index undefined Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::startPlaybackTimer Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 7 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand stop took 6 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 4 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 3 milliseconds Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:03 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 4 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand clear took 3 milliseconds Apr 27 09:26:03 volumio volumio[3249]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 9ms Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 7ms Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: verbose: STATE SERVICE {"status":"stop","position":9,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Woman","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:03 volumio volumio[3249]: verbose: CURRENT POSITION 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState stateService stop Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: No code Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 24ms Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:03 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:03 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:03 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:03 volumio volumio[3249]: error: updateQueue error: null Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:03 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 19ms Apr 27 09:26:03 volumio volumio[3249]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" took 17 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 5ms Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 4ms Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 3ms Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 23ms Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand play Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:03 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:03 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:03 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 18ms Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand play took 25 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 22ms Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 21ms Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 21ms Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 14 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 13 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 27 09:26:03 volumio volumio[3249]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 27 09:26:03 volumio volumio[3249]: error: FusionDsp - File size not found in array! Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 40 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 39 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 38 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 37 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 37 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 36 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 10 milliseconds Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":10,"seek":0,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"609 Kbps","isStreaming":false,"title":"Beautiful Boys","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:03 volumio volumio[3249]: verbose: CURRENT POSITION 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":10,"seek":958,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"604 Kbps","isStreaming":false,"title":"Beautiful Boys","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:03 volumio volumio[3249]: verbose: CURRENT POSITION 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:03 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 66ms Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 68ms Apr 27 09:26:03 volumio volumio[3249]: info: Apr 27 09:26:03 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 15 milliseconds Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":10,"seek":958,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"569 Kbps","isStreaming":false,"title":"Beautiful Boys","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:03 volumio volumio[3249]: verbose: CURRENT POSITION 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:03 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":10,"seek":958,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"569 Kbps","isStreaming":false,"title":"Beautiful Boys","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:03 volumio volumio[3249]: verbose: CURRENT POSITION 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:03 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":10,"seek":958,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"569 Kbps","isStreaming":false,"title":"Beautiful Boys","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:03 volumio volumio[3249]: verbose: CURRENT POSITION 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:03 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":10,"seek":958,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"569 Kbps","isStreaming":false,"title":"Beautiful Boys","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:03 volumio volumio[3249]: verbose: CURRENT POSITION 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:03 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":10,"seek":958,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"569 Kbps","isStreaming":false,"title":"Beautiful Boys","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:03 volumio volumio[3249]: verbose: CURRENT POSITION 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:03 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:03 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2002. Apr 27 09:26:03 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 100ms Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 89ms Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 88ms Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 87ms Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 86ms Apr 27 09:26:03 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand status took 59 milliseconds Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:03 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 09:26:03 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:03 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":10,"seek":958,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"569 Kbps","isStreaming":false,"title":"Beautiful Boys","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:03 volumio volumio[3249]: verbose: CURRENT POSITION 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:03 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[8095]: Traceback (most recent call last): Apr 27 09:26:03 volumio volumio[8095]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:03 volumio volumio[8095]: from aiohttp import web Apr 27 09:26:03 volumio volumio[8095]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:03 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:03 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:03 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:03 volumio volumio[3249]: info: ------------------------------ 83ms Apr 27 09:26:03 volumio volumio[3249]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 27 09:26:03 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:03 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:06 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:06 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2003. Apr 27 09:26:06 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:06 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:06 volumio volumio[8098]: Traceback (most recent call last): Apr 27 09:26:06 volumio volumio[8098]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:06 volumio volumio[8098]: from aiohttp import web Apr 27 09:26:06 volumio volumio[8098]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:06 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:06 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioNext Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::next Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::stop Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::serviceStop Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 10 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::serviceStop Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::stop Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand stop took 9 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::play index undefined Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::startPlaybackTimer Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 6 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand stop took 5 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 5 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 4 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 3 milliseconds Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:06 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand clear took 3 milliseconds Apr 27 09:26:06 volumio volumio[3249]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Apr 27 09:26:06 volumio volumio[3249]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Apr 27 09:26:06 volumio volumio[3249]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 9ms Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 8ms Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 7ms Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: verbose: STATE SERVICE {"status":"stop","position":10,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Boys","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:06 volumio volumio[3249]: verbose: CURRENT POSITION 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState stateService stop Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: No code Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 30ms Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:06 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:06 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:06 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:06 volumio volumio[3249]: error: updateQueue error: null Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:06 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 20ms Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" took 19 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 3ms Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 3ms Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 2ms Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand play Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:06 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:06 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:06 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 7ms Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand play took 6 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 6ms Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 5ms Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 13ms Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 27 09:26:06 volumio volumio[3249]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 27 09:26:06 volumio volumio[3249]: error: FusionDsp - File size not found in array! Apr 27 09:26:06 volumio volumio[3249]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 27 09:26:06 volumio volumio[3249]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 27 09:26:06 volumio volumio[3249]: error: FusionDsp - File size not found in array! Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 47 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 48 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 48 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 47 milliseconds Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: Apr 27 09:26:06 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 8 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 7 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 5 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand status took 4 milliseconds Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":11,"seek":0,"duration":154,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dear Yoko","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:06 volumio volumio[3249]: verbose: CURRENT POSITION 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":11,"seek":0,"duration":154,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dear Yoko","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:06 volumio volumio[3249]: verbose: CURRENT POSITION 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:06 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":11,"seek":22,"duration":154,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dear Yoko","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:06 volumio volumio[3249]: verbose: CURRENT POSITION 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:06 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":11,"seek":45,"duration":154,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dear Yoko","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:06 volumio volumio[3249]: verbose: CURRENT POSITION 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:06 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 72ms Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 76ms Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 76ms Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 76ms Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 20 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 19 milliseconds Apr 27 09:26:06 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 20 milliseconds Apr 27 09:26:06 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":11,"seek":958,"duration":154,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"973 Kbps","isStreaming":false,"title":"Dear Yoko","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:06 volumio volumio[3249]: verbose: CURRENT POSITION 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:06 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":11,"seek":958,"duration":154,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"973 Kbps","isStreaming":false,"title":"Dear Yoko","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:06 volumio volumio[3249]: verbose: CURRENT POSITION 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:06 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":11,"seek":958,"duration":154,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"973 Kbps","isStreaming":false,"title":"Dear Yoko","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:06 volumio volumio[3249]: verbose: CURRENT POSITION 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:06 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":11,"seek":958,"duration":154,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"973 Kbps","isStreaming":false,"title":"Dear Yoko","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:06 volumio volumio[3249]: verbose: CURRENT POSITION 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:06 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:06 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:06 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 61ms Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 58ms Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 57ms Apr 27 09:26:06 volumio volumio[3249]: info: ------------------------------ 57ms Apr 27 09:26:06 volumio volumio[3249]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 27 09:26:06 volumio volumio[3249]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 27 09:26:08 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:08 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2004. Apr 27 09:26:08 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:08 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:08 volumio volumio[8102]: Traceback (most recent call last): Apr 27 09:26:08 volumio volumio[8102]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:08 volumio volumio[8102]: from aiohttp import web Apr 27 09:26:08 volumio volumio[8102]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:08 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:08 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:10 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:10 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2005. Apr 27 09:26:10 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:10 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:10 volumio volumio[8103]: Traceback (most recent call last): Apr 27 09:26:10 volumio volumio[8103]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:10 volumio volumio[8103]: from aiohttp import web Apr 27 09:26:10 volumio volumio[8103]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:10 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:10 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::volumioNext Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::next Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::stop Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::serviceStop Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 11 Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::serviceStop Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::stop Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand stop took 11 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::play index undefined Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::startPlaybackTimer Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand status took 8 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand stop took 7 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand status took 3 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand status took 2 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand status took 1 milliseconds Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:11 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand clear took 5 milliseconds Apr 27 09:26:11 volumio volumio[3249]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" Apr 27 09:26:11 volumio volumio[3249]: info: ------------------------------ 12ms Apr 27 09:26:11 volumio volumio[3249]: info: ------------------------------ 8ms Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: verbose: STATE SERVICE {"status":"stop","position":11,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dear Yoko","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:11 volumio volumio[3249]: verbose: CURRENT POSITION 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::syncState stateService stop Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:11 volumio volumio[3249]: info: No code Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:11 volumio volumio[3249]: info: ------------------------------ 26ms Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:11 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:11 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:11 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:11 volumio volumio[3249]: error: updateQueue error: null Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:11 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:11 volumio volumio[3249]: info: ------------------------------ 15ms Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" took 14 milliseconds Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand play Apr 27 09:26:11 volumio volumio[3249]: info: ------------------------------ 26ms Apr 27 09:26:11 volumio volumio[3249]: info: ------------------------------ 25ms Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:11 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:11 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:11 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:11 volumio volumio[3249]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 27 09:26:11 volumio volumio[3249]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 27 09:26:11 volumio volumio[3249]: error: FusionDsp - File size not found in array! Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:11 volumio volumio[3249]: info: ------------------------------ 38ms Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand play took 38 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:11 volumio volumio[3249]: info: ------------------------------ 14ms Apr 27 09:26:11 volumio volumio[3249]: info: ------------------------------ 9ms Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:11 volumio volumio[3249]: info: Apr 27 09:26:11 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand status took 5 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand status took 4 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand status took 2 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand status took 1 milliseconds Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 27 09:26:11 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 27 09:26:11 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":12,"seek":958,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"608 Kbps","isStreaming":false,"title":"Every Man Has A Woman Who Loves Him","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:11 volumio volumio[3249]: verbose: CURRENT POSITION 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":12,"seek":958,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"608 Kbps","isStreaming":false,"title":"Every Man Has A Woman Who Loves Him","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:11 volumio volumio[3249]: verbose: CURRENT POSITION 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:11 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":12,"seek":958,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"608 Kbps","isStreaming":false,"title":"Every Man Has A Woman Who Loves Him","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:11 volumio volumio[3249]: verbose: CURRENT POSITION 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:11 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:11 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:11 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":12,"seek":958,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"608 Kbps","isStreaming":false,"title":"Every Man Has A Woman Who Loves Him","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:11 volumio volumio[3249]: verbose: CURRENT POSITION 12 Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:11 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:11 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:11 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:12 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:12 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:12 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:12 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:12 volumio volumio[3249]: info: ------------------------------ 43ms Apr 27 09:26:12 volumio volumio[3249]: info: ------------------------------ 49ms Apr 27 09:26:12 volumio volumio[3249]: info: ------------------------------ 49ms Apr 27 09:26:12 volumio volumio[3249]: info: ------------------------------ 46ms Apr 27 09:26:12 volumio volumio[3249]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 27 09:26:12 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:12 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2006. Apr 27 09:26:12 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:12 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:12 volumio volumio[8106]: Traceback (most recent call last): Apr 27 09:26:12 volumio volumio[8106]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:12 volumio volumio[8106]: from aiohttp import web Apr 27 09:26:12 volumio volumio[8106]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:12 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:12 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioNext Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::next Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::stop Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::serviceStop Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 12 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::serviceStop Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::stop Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand stop took 4 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::play index undefined Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::startPlaybackTimer Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 5 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand stop took 3 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 3 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 2 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 1 milliseconds Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:14 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand clear took 3 milliseconds Apr 27 09:26:14 volumio volumio[3249]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 6ms Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 5ms Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: verbose: STATE SERVICE {"status":"stop","position":12,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Every Man Has A Woman Who Loves Him","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:14 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState stateService stop Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: No code Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 19ms Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:14 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:14 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:14 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:14 volumio volumio[3249]: error: updateQueue error: null Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:14 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 15ms Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand load "INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).cue" took 14 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 4ms Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 3ms Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand play Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:14 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:14 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces system playlist update Apr 27 09:26:14 volumio volumio[3249]: info: Ignoring MPD Status Update Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 29ms Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand play took 28 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 24ms Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 23ms Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 23ms Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 14 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 9 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 6 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 3 milliseconds Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: Apr 27 09:26:14 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:14 volumio volumio[3249]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 27 09:26:14 volumio volumio[3249]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 27 09:26:14 volumio volumio[3249]: error: FusionDsp - File size not found in array! Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 25 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 24 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 24 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 24 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 23 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 23 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 19 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand status took 15 milliseconds Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":13,"seek":456,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"430 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:14 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus stop Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":13,"seek":456,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"430 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:14 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:14 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":13,"seek":456,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"430 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:14 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:14 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":13,"seek":456,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"430 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:14 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:14 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 86ms Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 97ms Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 90ms Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 87ms Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 59 milliseconds Apr 27 09:26:14 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 54 milliseconds Apr 27 09:26:14 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":13,"seek":456,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"430 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:14 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:14 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":13,"seek":456,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"430 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:14 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:14 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":13,"seek":456,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"430 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:14 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:14 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: verbose: STATE SERVICE {"status":"play","position":13,"seek":456,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"430 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:14 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState stateService play Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus play Apr 27 09:26:14 volumio volumio[3249]: info: Received an update from plugin. extracting info from payload Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:14 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:14 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 117ms Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 116ms Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 116ms Apr 27 09:26:14 volumio volumio[3249]: info: ------------------------------ 109ms Apr 27 09:26:14 volumio volumio[3249]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 27 09:26:15 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:15 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2007. Apr 27 09:26:15 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:15 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:15 volumio volumio[8109]: Traceback (most recent call last): Apr 27 09:26:15 volumio volumio[8109]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:15 volumio volumio[8109]: from aiohttp import web Apr 27 09:26:15 volumio volumio[8109]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:15 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:15 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:17 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:17 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2008. Apr 27 09:26:17 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:17 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:17 volumio volumio[8110]: Traceback (most recent call last): Apr 27 09:26:17 volumio volumio[8110]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:17 volumio volumio[8110]: from aiohttp import web Apr 27 09:26:17 volumio volumio[8110]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:17 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:17 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:19 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:19 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2009. Apr 27 09:26:19 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:19 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:19 volumio volumio[8111]: Traceback (most recent call last): Apr 27 09:26:19 volumio volumio[8111]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:19 volumio volumio[8111]: from aiohttp import web Apr 27 09:26:19 volumio volumio[8111]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:19 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:19 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:19 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 09:26:19 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 09:26:19 volumio volumio[3249]: info: Discovery: Getting this device information Apr 27 09:26:19 volumio volumio[3249]: info: CoreCommandRouter::volumioGetState Apr 27 09:26:19 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:19 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 09:26:21 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:21 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2010. Apr 27 09:26:21 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:21 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:21 volumio volumio[8112]: Traceback (most recent call last): Apr 27 09:26:21 volumio volumio[8112]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:21 volumio volumio[8112]: from aiohttp import web Apr 27 09:26:21 volumio volumio[8112]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:21 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:21 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:24 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:24 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2011. Apr 27 09:26:24 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:24 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:24 volumio volumio[8113]: Traceback (most recent call last): Apr 27 09:26:24 volumio volumio[8113]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:24 volumio volumio[8113]: from aiohttp import web Apr 27 09:26:24 volumio volumio[8113]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:24 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:24 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:26 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:26 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2012. Apr 27 09:26:26 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:26 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:26 volumio volumio[8115]: Traceback (most recent call last): Apr 27 09:26:26 volumio volumio[8115]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:26 volumio volumio[8115]: from aiohttp import web Apr 27 09:26:26 volumio volumio[8115]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:26 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:26 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:28 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:28 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2013. Apr 27 09:26:28 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:28 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:28 volumio volumio[8116]: Traceback (most recent call last): Apr 27 09:26:28 volumio volumio[8116]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:28 volumio volumio[8116]: from aiohttp import web Apr 27 09:26:28 volumio volumio[8116]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:28 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:28 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:30 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:30 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2014. Apr 27 09:26:30 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:30 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:30 volumio volumio[8117]: Traceback (most recent call last): Apr 27 09:26:30 volumio volumio[8117]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:30 volumio volumio[8117]: from aiohttp import web Apr 27 09:26:30 volumio volumio[8117]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:30 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:30 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:31 volumio volumio[3249]: info: CoreCommandRouter::volumioPause Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::pause Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::servicePause Apr 27 09:26:31 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:31 volumio volumio[3249]: info: CoreCommandRouter::servicePause Apr 27 09:26:31 volumio volumio[3249]: info: ControllerMpd::pause Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand pause Apr 27 09:26:31 volumio volumio[3249]: info: Apr 27 09:26:31 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:31 volumio volumio[3249]: info: sendMpdCommand pause took 1 milliseconds Apr 27 09:26:31 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:31 volumio volumio[3249]: info: Apr 27 09:26:31 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:31 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:31 volumio volumio[3249]: info: Apr 27 09:26:31 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:31 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:31 volumio volumio[3249]: info: Apr 27 09:26:31 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:31 volumio volumio[3249]: info: ControllerMpd::getState Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand status Apr 27 09:26:31 volumio volumio[3249]: info: sendMpdCommand status took 2 milliseconds Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:31 volumio volumio[3249]: info: sendMpdCommand status took 2 milliseconds Apr 27 09:26:31 volumio volumio[3249]: info: sendMpdCommand status took 3 milliseconds Apr 27 09:26:31 volumio volumio[3249]: info: sendMpdCommand status took 2 milliseconds Apr 27 09:26:31 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::parseState Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:31 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:31 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:31 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:31 volumio volumio[3249]: verbose: STATE SERVICE {"status":"pause","position":13,"seek":17838,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"783 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:31 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::syncState stateService pause Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus pause Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:31 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:31 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:31 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:26:31 volumio volumio[3249]: info: ------------------------------ 7ms Apr 27 09:26:31 volumio volumio[3249]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 27 09:26:31 volumio volumio[3249]: verbose: ControllerMpd::parseTrackInfo Apr 27 09:26:31 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:31 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:31 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:31 volumio volumio[3249]: verbose: STATE SERVICE {"status":"pause","position":13,"seek":17838,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"783 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:31 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::syncState stateService pause Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus pause Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:31 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:31 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:26:31 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:31 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:31 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:31 volumio volumio[3249]: verbose: STATE SERVICE {"status":"pause","position":13,"seek":17838,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"783 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:31 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::syncState stateService pause Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus pause Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:31 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:31 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:26:31 volumio volumio[3249]: info: ControllerMpd::pushState Apr 27 09:26:31 volumio volumio[3249]: info: CoreCommandRouter::servicePushState Apr 27 09:26:31 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:31 volumio volumio[3249]: verbose: STATE SERVICE {"status":"pause","position":13,"seek":17838,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"783 Kbps","isStreaming":false,"title":"Hard Times Are Over","artist":"John Lennon","album":"Double Fantasy (MFSL)","uri":"INTERNAL/John Lennon/John80/John Lennon - Double Fantasy (MFSL).flac","trackType":"flac"} Apr 27 09:26:31 volumio volumio[3249]: verbose: CURRENT POSITION 13 Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::syncState stateService pause Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::syncState currentStatus pause Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:31 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:31 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:31 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:26:31 volumio volumio[3249]: info: ------------------------------ 17ms Apr 27 09:26:31 volumio volumio[3249]: info: ------------------------------ 18ms Apr 27 09:26:31 volumio volumio[3249]: info: ------------------------------ 17ms Apr 27 09:26:33 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:33 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2015. Apr 27 09:26:33 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:33 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:33 volumio volumio[8169]: Traceback (most recent call last): Apr 27 09:26:33 volumio volumio[8169]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:33 volumio volumio[8169]: from aiohttp import web Apr 27 09:26:33 volumio volumio[8169]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:33 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:33 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:35 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:35 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2016. Apr 27 09:26:35 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:35 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:35 volumio volumio[8170]: Traceback (most recent call last): Apr 27 09:26:35 volumio volumio[8170]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:35 volumio volumio[8170]: from aiohttp import web Apr 27 09:26:35 volumio volumio[8170]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:35 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:35 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:37 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:37 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2017. Apr 27 09:26:37 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:37 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:37 volumio volumio[8171]: Traceback (most recent call last): Apr 27 09:26:37 volumio volumio[8171]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:37 volumio volumio[8171]: from aiohttp import web Apr 27 09:26:37 volumio volumio[8171]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:37 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:37 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:38 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 27 09:26:38 volumio volumio[3249]: info: CURURI: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC] Apr 27 09:26:38 volumio volumio[3249]: info: Preload queue cleared Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/01. Imagine.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/02. Crippled inside Take 2.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/03. Jealous guy Take 1.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/04. It's so hard Take 2.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/05. I don't want to be a soldier Take 1 with sax.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/06. Gimme some trues.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/07. Oh my love.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/08. How Do You Sleep_ Take 2.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/09. How_ Take 12.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/10. Oh Yoko! Take 9.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/11. I'm the greatest.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/12. San Francisco bay blues.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/13. Well baby pleace don t go.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/14. Imagine Rehearsal.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/15. Crippled inside Take 17.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/16. How_ - Child of nature - Oh Yoko!.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/17. Oh MyLove.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/18. Oh Yoko!.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/19. Jealous guy (Chikd of nature).flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/20. Gimme some trues.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/21. Imagine One to One consert.flac Apr 27 09:26:38 volumio volumio[3249]: info: Preloading song: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/22. It's so hard .flac Apr 27 09:26:38 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/01. Imagine.flac in service mpd Apr 27 09:26:38 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F01.%20Imagine.flac&metadata=false Apr 27 09:26:38 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/01. Imagine.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/02. Crippled inside Take 2.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F02.%20Crippled%20inside%20Take%202.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/02. Crippled inside Take 2.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/03. Jealous guy Take 1.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F03.%20Jealous%20guy%20Take%201.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/03. Jealous guy Take 1.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/04. It's so hard Take 2.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F04.%20It's%20so%20hard%20Take%202.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/04. It's so hard Take 2.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/05. I don't want to be a soldier Take 1 with sax.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F05.%20I%20don't%20want%20to%20be%20a%20soldier%20Take%201%20with%20sax.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/05. I don't want to be a soldier Take 1 with sax.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/06. Gimme some trues.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F06.%20Gimme%20some%20trues.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/06. Gimme some trues.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/07. Oh my love.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F07.%20Oh%20my%20love.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/07. Oh my love.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/08. How Do You Sleep_ Take 2.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F08.%20How%20Do%20You%20Sleep_%20Take%202.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/08. How Do You Sleep_ Take 2.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/09. How_ Take 12.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F09.%20How_%20Take%2012.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/09. How_ Take 12.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/10. Oh Yoko! Take 9.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F10.%20Oh%20Yoko!%20Take%209.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/10. Oh Yoko! Take 9.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/11. I'm the greatest.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F11.%20I'm%20the%20greatest.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/11. I'm the greatest.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/12. San Francisco bay blues.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F12.%20San%20Francisco%20bay%20blues.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/12. San Francisco bay blues.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/13. Well baby pleace don t go.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F13.%20Well%20baby%20pleace%20don%20t%20go.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/13. Well baby pleace don t go.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/14. Imagine Rehearsal.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F14.%20Imagine%20Rehearsal.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/14. Imagine Rehearsal.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/15. Crippled inside Take 17.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F15.%20Crippled%20inside%20Take%2017.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/15. Crippled inside Take 17.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/16. How_ - Child of nature - Oh Yoko!.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F16.%20How_%20-%20Child%20of%20nature%20-%20Oh%20Yoko!.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/16. How_ - Child of nature - Oh Yoko!.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/17. Oh MyLove.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F17.%20Oh%20MyLove.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/17. Oh MyLove.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/18. Oh Yoko!.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F18.%20Oh%20Yoko!.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/18. Oh Yoko!.flac Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/19. Jealous guy (Chikd of nature).flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F19.%20Jealous%20guy%20(Chikd%20of%20nature).flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/19. Jealous guy (Chikd of nature).flac Apr 27 09:26:39 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:39 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2018. Apr 27 09:26:39 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:39 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/20. Gimme some trues.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F20.%20Gimme%20some%20trues.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/20. Gimme some trues.flac Apr 27 09:26:39 volumio volumio[8172]: Traceback (most recent call last): Apr 27 09:26:39 volumio volumio[8172]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:39 volumio volumio[8172]: from aiohttp import web Apr 27 09:26:39 volumio volumio[8172]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:39 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:39 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:39 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/21. Imagine One to One consert.flac in service mpd Apr 27 09:26:39 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F21.%20Imagine%20One%20to%20One%20consert.flac&metadata=false Apr 27 09:26:39 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/21. Imagine One to One consert.flac Apr 27 09:26:40 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/22. It's so hard .flac in service mpd Apr 27 09:26:40 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F22.%20It's%20so%20hard%20.flac&metadata=false Apr 27 09:26:40 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/22. It's so hard .flac Apr 27 09:26:42 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 27 09:26:42 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2019. Apr 27 09:26:42 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 27 09:26:42 volumio systemd[1]: Started FusionDsp Daemon. Apr 27 09:26:42 volumio volumio[8173]: Traceback (most recent call last): Apr 27 09:26:42 volumio volumio[8173]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 27 09:26:42 volumio volumio[8173]: from aiohttp import web Apr 27 09:26:42 volumio volumio[8173]: ModuleNotFoundError: No module named 'aiohttp' Apr 27 09:26:42 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 27 09:26:42 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 27 09:26:43 volumio volumio[3249]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 27 09:26:43 volumio volumio[3249]: info: CoreStateMachine::ClearQueue Apr 27 09:26:43 volumio volumio[3249]: info: CoreStateMachine::stop Apr 27 09:26:43 volumio volumio[3249]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 09:26:43 volumio volumio[3249]: info: CoreStateMachine::updateTrackBlock Apr 27 09:26:43 volumio volumio[3249]: info: CorePlayQueue::getTrackBlock Apr 27 09:26:43 volumio volumio[3249]: info: CoreStateMachine::stPlaybackTimer Apr 27 09:26:43 volumio volumio[3249]: info: CoreStateMachine::pushState Apr 27 09:26:43 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:43 volumio volumio[3249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 09:26:43 volumio volumio[3249]: info: CoreCommandRouter::volumioPushState Apr 27 09:26:43 volumio volumio[3249]: info: CoreStateMachine::serviceStop Apr 27 09:26:43 volumio volumio[3249]: info: CorePlayQueue::getTrack 13 Apr 27 09:26:43 volumio volumio[3249]: info: CoreCommandRouter::serviceStop Apr 27 09:26:43 volumio volumio[3249]: info: ControllerMpd::stop Apr 27 09:26:43 volumio volumio[3249]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 09:26:43 volumio volumio[3249]: info: CorePlayQueue::clearPlayQueue Apr 27 09:26:43 volumio volumio[3249]: info: CorePlayQueue::saveQueue Apr 27 09:26:43 volumio volumio[3249]: info: CoreCommandRouter::volumioPushQueue Apr 27 09:26:43 volumio volumio[3249]: info: CoreStateMachine::addQueueItems Apr 27 09:26:43 volumio volumio[3249]: info: CorePlayQueue::addQueueItems Apr 27 09:26:43 volumio volumio[3249]: info: Preload queue cleared Apr 27 09:26:43 volumio volumio[3249]: info: Adding Item to queue: music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC] Apr 27 09:26:43 volumio volumio[3249]: info: Exploding uri music-library/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC] in service mpd Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F01.%20Imagine.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/01. Imagine.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F02.%20Crippled%20inside%20Take%202.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/02. Crippled inside Take 2.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F03.%20Jealous%20guy%20Take%201.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/03. Jealous guy Take 1.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F04.%20It's%20so%20hard%20Take%202.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/04. It's so hard Take 2.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F05.%20I%20don't%20want%20to%20be%20a%20soldier%20Take%201%20with%20sax.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/05. I don't want to be a soldier Take 1 with sax.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F06.%20Gimme%20some%20trues.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/06. Gimme some trues.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F07.%20Oh%20my%20love.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/07. Oh my love.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F08.%20How%20Do%20You%20Sleep_%20Take%202.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/08. How Do You Sleep_ Take 2.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F09.%20How_%20Take%2012.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/09. How_ Take 12.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F10.%20Oh%20Yoko!%20Take%209.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/10. Oh Yoko! Take 9.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F11.%20I'm%20the%20greatest.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/11. I'm the greatest.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F12.%20San%20Francisco%20bay%20blues.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/12. San Francisco bay blues.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F13.%20Well%20baby%20pleace%20don%20t%20go.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/13. Well baby pleace don t go.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F14.%20Imagine%20Rehearsal.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/14. Imagine Rehearsal.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F15.%20Crippled%20inside%20Take%2017.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/15. Crippled inside Take 17.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F16.%20How_%20-%20Child%20of%20nature%20-%20Oh%20Yoko!.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/16. How_ - Child of nature - Oh Yoko!.flac Apr 27 09:26:43 volumio volumio[3249]: info: Apr 27 09:26:43 volumio volumio[3249]: ---------------------------- MPD announces state update: player Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F17.%20Oh%20MyLove.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/17. Oh MyLove.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F18.%20Oh%20Yoko!.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/18. Oh Yoko!.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F19.%20Jealous%20guy%20(Chikd%20of%20nature).flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/19. Jealous guy (Chikd of nature).flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F20.%20Gimme%20some%20trues.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/20. Gimme some trues.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F21.%20Imagine%20One%20to%20One%20consert.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/21. Imagine One to One consert.flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2F22.%20It's%20so%20hard%20.flac&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/22. It's so hard .flac Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine.cue&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/John Lennon - The Alternativ Imagine.cue Apr 27 09:26:43 volumio volumio[3249]: info: ALBUMART /albumart?cacheid=997&web=John%20Lennon/The%20Alternativ%20Imagine/extralarge&path=%2Fmnt%2FINTERNAL%2FJohn%20Lennon%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine%20(2005)%20%5BFLAC%5D%2FJohn%20Lennon%20-%20The%20Alternativ%20Imagine.cue&metadata=false Apr 27 09:26:43 volumio volumio[3249]: info: URI /mnt/INTERNAL/John Lennon/John Lennon - The Alternativ Imagine (2005) [FLAC]/John Lennon - The Alternativ Imagine.cue Apr 27 09:26:43 volumio volumio[3249]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 09:26:43 volumio volumio[3249]: Error: Unable to resolve or reject the same promise twice Apr 27 09:26:43 volumio volumio[3249]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 27 09:26:43 volumio volumio[3249]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 27 09:26:43 volumio volumio[3249]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 27 09:26:43 volumio volumio[3249]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 27 09:26:43 volumio volumio[3249]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 27 09:26:43 volumio volumio[3249]: at Socket.emit (events.js:400:28) Apr 27 09:26:43 volumio volumio[3249]: at addChunk (internal/streams/readable.js:293:12) Apr 27 09:26:43 volumio volumio[3249]: at readableAddChunk (internal/streams/readable.js:263:11) Apr 27 09:26:43 volumio volumio[3249]: at Socket.Readable.push (internal/streams/readable.js:206:10) Apr 27 09:26:43 volumio volumio[3249]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 27 09:26:43 volumio volumio[3249]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 09:26:43 volumio sudo[8183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-27 09:25 Apr 27 09:26:43 volumio sudo[8183]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="9552505bba4239c163ac9ee7b0b87a56e0dd0574" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="3d3fc502273a5c173ba19f72c1a952bdb2bdd3b0" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 Feb 2024 07:28:53 PM CET" VOLUMIO_VERSION="3.616" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="f11d51aa83fa91106999927181e8c0f7"