-- Logs begin at Wed 2024-05-15 11:54:46 UTC, end at Wed 2024-05-15 12:10:01 UTC. -- May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::volumioPlay May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::play index 58 May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::stop May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::stPlaybackTimer May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::updateTrackBlock May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrackBlock May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 0 May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::serviceStop May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 0 May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::serviceStop May 15 12:09:06 volumio volumio[938]: info: ControllerMpd::stop May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand stop May 15 12:09:06 volumio volumio[938]: info: May 15 12:09:06 volumio volumio[938]: ---------------------------- MPD announces state update: player May 15 12:09:06 volumio volumio[938]: info: sendMpdCommand stop took 5 milliseconds May 15 12:09:06 volumio volumio[938]: info: ControllerMpd::getState May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::play index undefined May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::startPlaybackTimer May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music_DATA/Music2/杉 真理/杉 真理 いとしのテラ.flac May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand stop May 15 12:09:06 volumio volumio[938]: info: sendMpdCommand status took 2 milliseconds May 15 12:09:06 volumio volumio[938]: info: sendMpdCommand stop took 1 milliseconds May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::parseState May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand clear May 15 12:09:06 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 May 15 12:09:06 volumio volumio[938]: info: May 15 12:09:06 volumio volumio[938]: ---------------------------- MPD announces state update: player May 15 12:09:06 volumio volumio[938]: info: ControllerMpd::getState May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status May 15 12:09:06 volumio volumio[938]: info: May 15 12:09:06 volumio volumio[938]: ---------------------------- MPD announces state update: player May 15 12:09:06 volumio volumio[938]: info: ControllerMpd::getState May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status May 15 12:09:06 volumio volumio[938]: info: May 15 12:09:06 volumio volumio[938]: ---------------------------- MPD announces system playlist update May 15 12:09:06 volumio volumio[938]: info: Ignoring MPD Status Update May 15 12:09:06 volumio volumio[938]: info: sendMpdCommand playlistinfo took 32 milliseconds May 15 12:09:06 volumio volumio[938]: info: sendMpdCommand clear took 32 milliseconds May 15 12:09:06 volumio volumio[938]: info: sendMpdCommand status took 6 milliseconds May 15 12:09:06 volumio volumio[938]: info: sendMpdCommand status took 3 milliseconds May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music_DATA/Music2/杉 真理/杉 真理 いとしのテラ.flac" May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::parseState May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::parseState May 15 12:09:06 volumio volumio[938]: info: ControllerMpd::pushState May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::servicePushState May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"バカンスはいつも雨","artist":"杉 真理","album":"STARGAZER","uri":"NAS/Music_DATA/Music2/杉 真理/STARGAZER/杉 真理 STARGAZER バカンスはいつも雨.flac","trackType":"flac"} May 15 12:09:06 volumio volumio[938]: verbose: CURRENT POSITION 58 May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::syncState stateService stop May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus stop May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:06 volumio volumio[938]: info: No code May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:06 volumio volumio[938]: info: ControllerMpd::pushState May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::servicePushState May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:09:06 volumio volumio[938]: verbose: CURRENT POSITION 58 May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::syncState stateService stop May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus stop May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:06 volumio volumio[938]: info: No code May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:06 volumio volumio[938]: info: ControllerMpd::pushState May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::servicePushState May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:09:06 volumio volumio[938]: verbose: CURRENT POSITION 58 May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::syncState stateService stop May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus stop May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:06 volumio volumio[938]: info: No code May 15 12:09:06 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:06 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:06 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:06 volumio volumio[938]: info: ------------------------------ 63ms May 15 12:09:06 volumio volumio[938]: info: ------------------------------ 36ms May 15 12:09:06 volumio volumio[938]: info: ------------------------------ 35ms May 15 12:09:06 volumio volumio[938]: info: May 15 12:09:06 volumio volumio[938]: ---------------------------- MPD announces system playlist update May 15 12:09:06 volumio volumio[938]: info: Ignoring MPD Status Update May 15 12:09:06 volumio volumio[938]: info: May 15 12:09:06 volumio volumio[938]: ---------------------------- MPD announces system playlist update May 15 12:09:06 volumio volumio[938]: info: Ignoring MPD Status Update May 15 12:09:06 volumio volumio[938]: error: updateQueue error: null May 15 12:09:06 volumio volumio[938]: info: May 15 12:09:06 volumio volumio[938]: ---------------------------- MPD announces system playlist update May 15 12:09:06 volumio volumio[938]: info: Ignoring MPD Status Update May 15 12:09:06 volumio volumio[938]: info: ------------------------------ 40ms May 15 12:09:06 volumio volumio[938]: info: sendMpdCommand add "NAS/Music_DATA/Music2/杉 真理/杉 真理 いとしのテラ.flac" took 36 milliseconds May 15 12:09:06 volumio volumio[938]: info: ------------------------------ 7ms May 15 12:09:06 volumio volumio[938]: info: ------------------------------ 6ms May 15 12:09:06 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand play May 15 12:09:06 volumio volumio[938]: info: May 15 12:09:06 volumio volumio[938]: ---------------------------- MPD announces system playlist update May 15 12:09:06 volumio volumio[938]: info: Ignoring MPD Status Update May 15 12:09:06 volumio volumio[938]: info: May 15 12:09:06 volumio volumio[938]: ---------------------------- MPD announces system playlist update May 15 12:09:06 volumio volumio[938]: info: Ignoring MPD Status Update May 15 12:09:06 volumio volumio[938]: info: touch_display: Setting screensaver timeout to 36000 seconds. May 15 12:09:06 volumio volumio[938]: info: ------------------------------ 17ms May 15 12:09:06 volumio volumio[938]: info: sendMpdCommand play took 15 milliseconds May 15 12:09:06 volumio volumio[938]: info: ------------------------------ 15ms May 15 12:09:06 volumio volumio[938]: info: ------------------------------ 14ms May 15 12:09:06 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 May 15 12:09:07 volumio volumio[938]: info: May 15 12:09:07 volumio volumio[938]: ---------------------------- MPD announces state update: player May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::getState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status May 15 12:09:07 volumio volumio[938]: info: May 15 12:09:07 volumio volumio[938]: ---------------------------- MPD announces state update: player May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::getState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status May 15 12:09:07 volumio volumio[938]: info: May 15 12:09:07 volumio volumio[938]: ---------------------------- MPD announces state update: player May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::getState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::volumioGetState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: info: May 15 12:09:07 volumio volumio[938]: ---------------------------- MPD announces state update: player May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::getState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand status took 23 milliseconds May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand status took 23 milliseconds May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand status took 21 milliseconds May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:09:07 volumio volumio[938]: info: May 15 12:09:07 volumio volumio[938]: ---------------------------- MPD announces state update: player May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::getState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status May 15 12:09:07 volumio volumio[938]: info: May 15 12:09:07 volumio volumio[938]: ---------------------------- MPD announces state update: player May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::getState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand status May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand status took 11 milliseconds May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand playlistinfo took 9 milliseconds May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand playlistinfo took 10 milliseconds May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand playlistinfo took 10 milliseconds May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand status took 10 milliseconds May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand status took 9 milliseconds May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseState May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::pushState May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::servicePushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1382,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1472 Kbps","isStreaming":false,"title":"いとしのテラ","artist":"杉 真理","album":null,"uri":"NAS/Music_DATA/Music2/杉 真理/杉 真理 いとしのテラ.flac","trackType":"flac"} May 15 12:09:07 volumio volumio[938]: verbose: CURRENT POSITION 58 May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState stateService play May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus stop May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::pushState May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::servicePushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1382,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1434 Kbps","isStreaming":false,"title":"いとしのテラ","artist":"杉 真理","album":null,"uri":"NAS/Music_DATA/Music2/杉 真理/杉 真理 いとしのテラ.flac","trackType":"flac"} May 15 12:09:07 volumio volumio[938]: verbose: CURRENT POSITION 58 May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState stateService play May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play May 15 12:09:07 volumio volumio[938]: info: Received an update from plugin. extracting info from payload May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::pushState May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::servicePushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1382,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1434 Kbps","isStreaming":false,"title":"いとしのテラ","artist":"杉 真理","album":null,"uri":"NAS/Music_DATA/Music2/杉 真理/杉 真理 いとしのテラ.flac","trackType":"flac"} May 15 12:09:07 volumio volumio[938]: verbose: CURRENT POSITION 58 May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState stateService play May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play May 15 12:09:07 volumio volumio[938]: info: Received an update from plugin. extracting info from payload May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:07 volumio volumio[938]: info: ------------------------------ 55ms May 15 12:09:07 volumio volumio[938]: info: ------------------------------ 66ms May 15 12:09:07 volumio volumio[938]: info: ------------------------------ 67ms May 15 12:09:07 volumio volumio[938]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand playlistinfo took 36 milliseconds May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand playlistinfo took 35 milliseconds May 15 12:09:07 volumio volumio[938]: info: sendMpdCommand playlistinfo took 35 milliseconds May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo May 15 12:09:07 volumio volumio[938]: verbose: ControllerMpd::parseTrackInfo May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::pushState May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::servicePushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1382,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1434 Kbps","isStreaming":false,"title":"いとしのテラ","artist":"杉 真理","album":null,"uri":"NAS/Music_DATA/Music2/杉 真理/杉 真理 いとしのテラ.flac","trackType":"flac"} May 15 12:09:07 volumio volumio[938]: verbose: CURRENT POSITION 58 May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState stateService play May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play May 15 12:09:07 volumio volumio[938]: info: Received an update from plugin. extracting info from payload May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::pushState May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::servicePushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1382,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1434 Kbps","isStreaming":false,"title":"いとしのテラ","artist":"杉 真理","album":null,"uri":"NAS/Music_DATA/Music2/杉 真理/杉 真理 いとしのテラ.flac","trackType":"flac"} May 15 12:09:07 volumio volumio[938]: verbose: CURRENT POSITION 58 May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState stateService play May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play May 15 12:09:07 volumio volumio[938]: info: Received an update from plugin. extracting info from payload May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:07 volumio volumio[938]: info: ControllerMpd::pushState May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::servicePushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1382,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1434 Kbps","isStreaming":false,"title":"いとしのテラ","artist":"杉 真理","album":null,"uri":"NAS/Music_DATA/Music2/杉 真理/杉 真理 いとしのテラ.flac","trackType":"flac"} May 15 12:09:07 volumio volumio[938]: verbose: CURRENT POSITION 58 May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState stateService play May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::syncState currentStatus play May 15 12:09:07 volumio volumio[938]: info: Received an update from plugin. extracting info from payload May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:07 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:07 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:07 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:07 volumio volumio[938]: info: ------------------------------ 80ms May 15 12:09:07 volumio volumio[938]: info: ------------------------------ 78ms May 15 12:09:07 volumio volumio[938]: info: ------------------------------ 77ms May 15 12:09:07 volumio volumio[938]: info: touch_display: Setting screensaver timeout to 36000 seconds. May 15 12:09:07 volumio volumio[938]: info: touch_display: Setting screensaver timeout to 0 seconds. May 15 12:09:43 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 15 12:09:43 volumio volumio[938]: info: CURURI: music-library/NAS/Music_DATA/Music3 May 15 12:09:43 volumio volumio[938]: info: Preload queue cleared May 15 12:09:51 volumio volumio[938]: info: Preload queue cleared May 15 12:09:51 volumio volumio[938]: info: CoreCommandRouter::volumioReplaceandPlayItems May 15 12:09:51 volumio volumio[938]: info: CoreStateMachine::ClearQueue May 15 12:09:51 volumio volumio[938]: info: CoreStateMachine::stop May 15 12:09:51 volumio volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:09:51 volumio volumio[938]: info: CoreStateMachine::stPlaybackTimer May 15 12:09:51 volumio volumio[938]: info: CoreStateMachine::updateTrackBlock May 15 12:09:51 volumio volumio[938]: info: CorePlayQueue::getTrackBlock May 15 12:09:51 volumio volumio[938]: info: CoreStateMachine::pushState May 15 12:09:51 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:51 volumio volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:09:51 volumio volumio[938]: info: CoreCommandRouter::volumioPushState May 15 12:09:51 volumio volumio[938]: info: CoreStateMachine::serviceStop May 15 12:09:51 volumio volumio[938]: info: CorePlayQueue::getTrack 58 May 15 12:09:51 volumio volumio[938]: info: CoreCommandRouter::serviceStop May 15 12:09:51 volumio volumio[938]: info: ControllerMpd::stop May 15 12:09:51 volumio volumio[938]: verbose: ControllerMpd::sendMpdCommand stop May 15 12:09:51 volumio volumio[938]: info: CorePlayQueue::clearPlayQueue May 15 12:09:51 volumio volumio[938]: info: CorePlayQueue::saveQueue May 15 12:09:51 volumio volumio[938]: info: CoreCommandRouter::volumioPushQueue May 15 12:09:51 volumio volumio[938]: info: CoreStateMachine::addQueueItems May 15 12:09:51 volumio volumio[938]: info: CorePlayQueue::addQueueItems May 15 12:09:51 volumio volumio[938]: info: Preload queue cleared May 15 12:09:51 volumio volumio[938]: info: Adding Item to queue: music-library/NAS/Music_DATA/Music3/Educator-Nishiyama May 15 12:09:51 volumio volumio[938]: info: Exploding uri music-library/NAS/Music_DATA/Music3/Educator-Nishiyama in service mpd May 15 12:10:00 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 May 15 12:10:00 volumio volumio[938]: info: May 15 12:10:00 volumio volumio[938]: ---------------------------- MPD announces state update: player May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2F01.%20Broadway%20Boogie%20Woogie.flac&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/01. Broadway Boogie Woogie.flac May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2F02.%20Kodo%20Kogen.flac&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/02. Kodo Kogen.flac May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2F03.%20Ballet%20Mecanique.flac&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/03. Ballet Mecanique.flac May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2F04.%20G.T.%20II.flac&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/04. G.T. II.flac May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2F05.%20Milan%2C%201909.flac&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/05. Milan, 1909.flac May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2F06.%20Variety%20Show.flac&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/06. Variety Show.flac May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2F07.%20Daikokai%20-%20Verso%20lo%20Schermo.flac&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/07. Daikokai - Verso lo Schermo.flac May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2F08.%20Water%20Is%20Life.flac&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/08. Water Is Life.flac May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2F09.%20Parolibre.flac&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/09. Parolibre.flac May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2F10.%20G.T..flac&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/10. G.T..flac May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2FRyuichi%20Sakamoto%20-%20Futurista.cue&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/Ryuichi Sakamoto - Futurista.cue May 15 12:10:00 volumio volumio[938]: info: ALBUMART /albumart?cacheid=733&web=Ryuichi%20Sakamoto/Futurista/large&path=%2Fmnt%2FNAS%2FMusic_DATA%2FMusic3%2FEducator-Nishiyama%2F1986%20Futurista%20flac%2FRyuichi%20Sakamoto%20-%20Futurista.cue&metadata=false May 15 12:10:00 volumio volumio[938]: info: URI /mnt/NAS/Music_DATA/Music3/Educator-Nishiyama/1986 Futurista flac/Ryuichi Sakamoto - Futurista.cue May 15 12:10:00 volumio volumio[938]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 12:10:00 volumio volumio[938]: Error: Unable to resolve or reject the same promise twice May 15 12:10:00 volumio volumio[938]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) May 15 12:10:00 volumio volumio[938]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 May 15 12:10:00 volumio volumio[938]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) May 15 12:10:00 volumio volumio[938]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) May 15 12:10:00 volumio volumio[938]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) May 15 12:10:00 volumio volumio[938]: at Socket.emit (events.js:315:20) May 15 12:10:00 volumio volumio[938]: at addChunk (internal/streams/readable.js:309:12) May 15 12:10:00 volumio volumio[938]: at readableAddChunk (internal/streams/readable.js:280:11) May 15 12:10:00 volumio volumio[938]: at Socket.Readable.push (internal/streams/readable.js:223:10) May 15 12:10:00 volumio volumio[938]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) May 15 12:10:00 volumio volumio[938]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 12:10:01 volumio sudo[9273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-15 12:09 May 15 12:10:01 volumio sudo[9273]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"