-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Tue 2024-04-16 21:39:33 CST. --
Apr 16 21:38:01 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::volumioGetState
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 36
Apr 16 21:38:03 volumio volumio[3030]: info: Listing playlists
Apr 16 21:38:03 volumio volumio[3030]: info: Listing playlists
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::volumioNext
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::next
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::stop
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::stPlaybackTimer
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 36
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::serviceStop
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 36
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::serviceStop
Apr 16 21:38:03 volumio volumio[3030]: info: ControllerMpd::stop
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:38:03 volumio volumio[3030]: info:
Apr 16 21:38:03 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:38:03 volumio volumio[3030]: info: sendMpdCommand stop took 97 milliseconds
Apr 16 21:38:03 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::play index undefined
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::startPlaybackTimer
Apr 16 21:38:03 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/单曲/celine dion - I'm Alive.mp3
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:38:03 volumio volumio[3030]: info: sendMpdCommand status took 6 milliseconds
Apr 16 21:38:03 volumio volumio[3030]: info: sendMpdCommand stop took 4 milliseconds
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand clear
Apr 16 21:38:03 volumio volumio[3030]: info:
Apr 16 21:38:03 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:38:03 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:38:03 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:38:03 volumio volumio[3030]: info: sendMpdCommand clear took 2 milliseconds
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/单曲/celine dion - I'm Alive.mp3"
Apr 16 21:38:03 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:03 volumio volumio[3030]: 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":"Beyond - 遥望.wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/Beyond - 遥望.wav","trackType":"wav"}
Apr 16 21:38:03 volumio volumio[3030]: verbose: CURRENT POSITION 37
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::syncState stateService stop
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:03 volumio volumio[3030]: info: No code
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:03 volumio volumio[3030]: info: ------------------------------ 57ms
Apr 16 21:38:03 volumio volumio[3030]: error: updateQueue error: null
Apr 16 21:38:03 volumio volumio[3030]: info:
Apr 16 21:38:03 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:38:03 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:38:03 volumio volumio[3030]: info: ------------------------------ 50ms
Apr 16 21:38:03 volumio volumio[3030]: info: sendMpdCommand add "NAS/ds918/单曲/celine dion - I'm Alive.mp3" took 43 milliseconds
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand play
Apr 16 21:38:03 volumio volumio[3030]: info: ------------------------------ 15ms
Apr 16 21:38:03 volumio volumio[3030]: info: sendMpdCommand play took 14 milliseconds
Apr 16 21:38:03 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:38:03 volumio volumio[3030]: info:
Apr 16 21:38:03 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:38:03 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:38:03 volumio volumio[3030]: info:
Apr 16 21:38:03 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:38:03 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:38:03 volumio volumio[3030]: info: sendMpdCommand status took 2 milliseconds
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:38:03 volumio volumio[3030]: info: sendMpdCommand status took 9 milliseconds
Apr 16 21:38:03 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 9 milliseconds
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:38:03 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:03 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":211,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I'm Alive","artist":"Celine Dion","album":null,"uri":"NAS/ds918/单曲/celine dion - I'm Alive.mp3","trackType":"mp3"}
Apr 16 21:38:03 volumio volumio[3030]: verbose: CURRENT POSITION 37
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:38:03 volumio volumio[3030]: info: ------------------------------ 15ms
Apr 16 21:38:03 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 40 milliseconds
Apr 16 21:38:03 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:38:03 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:03 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":211,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I'm Alive","artist":"Celine Dion","album":null,"uri":"NAS/ds918/单曲/celine dion - I'm Alive.mp3","trackType":"mp3"}
Apr 16 21:38:03 volumio volumio[3030]: verbose: CURRENT POSITION 37
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus play
Apr 16 21:38:03 volumio volumio[3030]: info: Received an update from plugin. extracting info from payload
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:03 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:03 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:03 volumio volumio[3030]: info: ------------------------------ 77ms
Apr 16 21:38:05 volumio volumio[3030]: info: MyVolumio login type: Token
Apr 16 21:38:06 volumio volumio[3030]: info: CoreCommandRouter::volumioNext
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::next
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::stop
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::stPlaybackTimer
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:38:06 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:06 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:06 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:38:06 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::serviceStop
Apr 16 21:38:06 volumio volumio[3030]: info: CorePlayQueue::getTrack 37
Apr 16 21:38:06 volumio volumio[3030]: info: CoreCommandRouter::serviceStop
Apr 16 21:38:06 volumio volumio[3030]: info: ControllerMpd::stop
Apr 16 21:38:06 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:38:06 volumio volumio[3030]: info:
Apr 16 21:38:06 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:38:06 volumio volumio[3030]: info: sendMpdCommand stop took 89 milliseconds
Apr 16 21:38:06 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:38:06 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::play index undefined
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:38:06 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::startPlaybackTimer
Apr 16 21:38:06 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:06 volumio volumio[3030]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/单曲/Ella - 后来 (Live).mp3
Apr 16 21:38:06 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:38:06 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:38:06 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:38:06 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:38:06 volumio volumio[3030]: info: sendMpdCommand stop took 2 milliseconds
Apr 16 21:38:06 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:38:06 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:38:06 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand clear
Apr 16 21:38:06 volumio volumio[3030]: info:
Apr 16 21:38:06 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:38:06 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:38:06 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:38:06 volumio volumio[3030]: info: sendMpdCommand clear took 2 milliseconds
Apr 16 21:38:06 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:38:06 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/单曲/Ella - 后来 (Live).mp3"
Apr 16 21:38:06 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:38:06 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:06 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:06 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:38:06 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:06 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:06 volumio volumio[3030]: 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":"I'm Alive","artist":"Celine Dion","album":null,"uri":"NAS/ds918/单曲/celine dion - I'm Alive.mp3","trackType":"mp3"}
Apr 16 21:38:06 volumio volumio[3030]: verbose: CURRENT POSITION 38
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::syncState stateService stop
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:06 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:06 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:06 volumio volumio[3030]: info: No code
Apr 16 21:38:06 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:06 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:06 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:06 volumio volumio[3030]: info: ------------------------------ 37ms
Apr 16 21:38:06 volumio volumio[3030]: error: updateQueue error: null
Apr 16 21:38:06 volumio volumio[3030]: info:
Apr 16 21:38:06 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:38:06 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:38:06 volumio volumio[3030]: info: ------------------------------ 33ms
Apr 16 21:38:06 volumio volumio[3030]: info: sendMpdCommand add "NAS/ds918/单曲/Ella - 后来 (Live).mp3" took 31 milliseconds
Apr 16 21:38:06 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand play
Apr 16 21:38:06 volumio volumio[3030]: info: ------------------------------ 15ms
Apr 16 21:38:06 volumio volumio[3030]: info: sendMpdCommand play took 14 milliseconds
Apr 16 21:38:06 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:38:07 volumio volumio[3030]: info:
Apr 16 21:38:07 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:38:07 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:38:07 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:38:07 volumio volumio[3030]: info:
Apr 16 21:38:07 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:38:07 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:38:07 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:38:07 volumio volumio[3030]: info: sendMpdCommand status took 6 milliseconds
Apr 16 21:38:07 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:38:07 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:38:07 volumio volumio[3030]: info: sendMpdCommand status took 51 milliseconds
Apr 16 21:38:07 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 49 milliseconds
Apr 16 21:38:07 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:38:07 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:38:07 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:38:07 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:38:07 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:38:07 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:07 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":308,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"后来 (Live)","artist":"S.H.E","album":null,"uri":"NAS/ds918/单曲/Ella - 后来 (Live).mp3","trackType":"mp3"}
Apr 16 21:38:07 volumio volumio[3030]: verbose: CURRENT POSITION 38
Apr 16 21:38:07 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:38:07 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:38:07 volumio volumio[3030]: info: ------------------------------ 73ms
Apr 16 21:38:07 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 16 21:38:07 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:38:07 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:38:07 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:38:07 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:07 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":308,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"后来 (Live)","artist":"S.H.E","album":null,"uri":"NAS/ds918/单曲/Ella - 后来 (Live).mp3","trackType":"mp3"}
Apr 16 21:38:07 volumio volumio[3030]: verbose: CURRENT POSITION 38
Apr 16 21:38:07 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:38:07 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus play
Apr 16 21:38:07 volumio volumio[3030]: info: Received an update from plugin. extracting info from payload
Apr 16 21:38:07 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:07 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:07 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:38:07 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:07 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:38:07 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:07 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:38:07 volumio volumio[3030]: info: ------------------------------ 87ms
Apr 16 21:38:07 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:38:13 volumio volumio[3030]: info: CoreCommandRouter::volumioGetState
Apr 16 21:38:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:13 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:38:16 volumio volumio[3030]: info: UPDATER: Scheduling automatic update
Apr 16 21:38:16 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Apr 16 21:38:16 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Apr 16 21:38:16 volumio volumio[3030]: info: UPDATER: Auto update will take place at: Wed Apr 17 2024 05:13:01 GMT+0800 (China Standard Time)
Apr 16 21:38:19 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:38:23 volumio volumio[3030]: info: CoreCommandRouter::volumioGetState
Apr 16 21:38:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:23 volumio volumio[3030]: info: Listing playlists
Apr 16 21:38:23 volumio volumio[3030]: info: Listing playlists
Apr 16 21:38:25 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:38:30 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:38:33 volumio volumio[3030]: info: CoreCommandRouter::volumioGetState
Apr 16 21:38:33 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:35 volumio volumio[3030]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Apr 16 21:38:35 volumio volumio[3030]: info: Retrying Login Due to Network Error
Apr 16 21:38:36 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:38:42 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:38:43 volumio volumio[3030]: info: CoreCommandRouter::volumioGetState
Apr 16 21:38:43 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:43 volumio volumio[3030]: info: Listing playlists
Apr 16 21:38:43 volumio volumio[3030]: info: Listing playlists
Apr 16 21:38:45 volumio volumio[3030]: info: MyVolumio login type: Token
Apr 16 21:38:48 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:38:53 volumio volumio[3030]: info: CoreCommandRouter::volumioGetState
Apr 16 21:38:53 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:38:54 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:38:59 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:39:03 volumio volumio[3030]: info: CoreCommandRouter::volumioGetState
Apr 16 21:39:03 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:39:03 volumio volumio[3030]: info: Listing playlists
Apr 16 21:39:03 volumio volumio[3030]: info: Listing playlists
Apr 16 21:39:05 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:39:11 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::volumioNext
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::next
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::stop
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::stPlaybackTimer
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::serviceStop
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 38
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::serviceStop
Apr 16 21:39:11 volumio volumio[3030]: info: ControllerMpd::stop
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:11 volumio volumio[3030]: info:
Apr 16 21:39:11 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:11 volumio volumio[3030]: info: sendMpdCommand stop took 96 milliseconds
Apr 16 21:39:11 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::play index undefined
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:11 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::startPlaybackTimer
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/单曲/Faded-Alan_Walker_Iselin_Solheim-6749207.flac
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:11 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:11 volumio volumio[3030]: info: sendMpdCommand stop took 2 milliseconds
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand clear
Apr 16 21:39:11 volumio volumio[3030]: info:
Apr 16 21:39:11 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:11 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:11 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:11 volumio volumio[3030]: info: sendMpdCommand clear took 2 milliseconds
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/单曲/Faded-Alan_Walker_Iselin_Solheim-6749207.flac"
Apr 16 21:39:11 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:11 volumio volumio[3030]: 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":"后来 (Live)","artist":"S.H.E","album":null,"uri":"NAS/ds918/单曲/Ella - 后来 (Live).mp3","trackType":"mp3"}
Apr 16 21:39:11 volumio volumio[3030]: verbose: CURRENT POSITION 39
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::syncState stateService stop
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:11 volumio volumio[3030]: info: No code
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:11 volumio volumio[3030]: info: ------------------------------ 37ms
Apr 16 21:39:11 volumio volumio[3030]: error: updateQueue error: null
Apr 16 21:39:11 volumio volumio[3030]: info:
Apr 16 21:39:11 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:11 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:11 volumio volumio[3030]: info: ------------------------------ 34ms
Apr 16 21:39:11 volumio volumio[3030]: info: sendMpdCommand add "NAS/ds918/单曲/Faded-Alan_Walker_Iselin_Solheim-6749207.flac" took 33 milliseconds
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand play
Apr 16 21:39:11 volumio volumio[3030]: info: ------------------------------ 11ms
Apr 16 21:39:11 volumio volumio[3030]: info: sendMpdCommand play took 10 milliseconds
Apr 16 21:39:11 volumio volumio[3030]: info:
Apr 16 21:39:11 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:11 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:11 volumio volumio[3030]: info:
Apr 16 21:39:11 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:11 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:11 volumio volumio[3030]: info: sendMpdCommand status took 2 milliseconds
Apr 16 21:39:11 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:11 volumio volumio[3030]: info: sendMpdCommand status took 2 milliseconds
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:11 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:11 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:11 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:11 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:11 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Faded","artist":"Alan Walker&Iselin Solheim","album":null,"uri":"NAS/ds918/单曲/Faded-Alan_Walker_Iselin_Solheim-6749207.flac","trackType":"flac"}
Apr 16 21:39:11 volumio volumio[3030]: verbose: CURRENT POSITION 39
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:11 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:11 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Faded","artist":"Alan Walker&Iselin Solheim","album":null,"uri":"NAS/ds918/单曲/Faded-Alan_Walker_Iselin_Solheim-6749207.flac","trackType":"flac"}
Apr 16 21:39:11 volumio volumio[3030]: verbose: CURRENT POSITION 39
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus play
Apr 16 21:39:11 volumio volumio[3030]: info: Received an update from plugin. extracting info from payload
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:11 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:11 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:11 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:11 volumio volumio[3030]: info: ------------------------------ 21ms
Apr 16 21:39:11 volumio volumio[3030]: info: ------------------------------ 54ms
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::volumioGetState
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::volumioNext
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::next
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::stop
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::stPlaybackTimer
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::serviceStop
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 39
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::serviceStop
Apr 16 21:39:13 volumio volumio[3030]: info: ControllerMpd::stop
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:13 volumio volumio[3030]: info:
Apr 16 21:39:13 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:13 volumio volumio[3030]: info: sendMpdCommand stop took 78 milliseconds
Apr 16 21:39:13 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::play index undefined
Apr 16 21:39:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::startPlaybackTimer
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/单曲/Jannik-Heart Linked.mp3
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:13 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:13 volumio volumio[3030]: info: sendMpdCommand stop took 2 milliseconds
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand clear
Apr 16 21:39:13 volumio volumio[3030]: info:
Apr 16 21:39:13 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:13 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:13 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:13 volumio volumio[3030]: info: sendMpdCommand clear took 1 milliseconds
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/单曲/Jannik-Heart Linked.mp3"
Apr 16 21:39:13 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:13 volumio volumio[3030]: 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":"Faded","artist":"Alan Walker&Iselin Solheim","album":null,"uri":"NAS/ds918/单曲/Faded-Alan_Walker_Iselin_Solheim-6749207.flac","trackType":"flac"}
Apr 16 21:39:13 volumio volumio[3030]: verbose: CURRENT POSITION 40
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::syncState stateService stop
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:13 volumio volumio[3030]: info: No code
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:13 volumio volumio[3030]: info: ------------------------------ 39ms
Apr 16 21:39:13 volumio volumio[3030]: error: updateQueue error: null
Apr 16 21:39:13 volumio volumio[3030]: info:
Apr 16 21:39:13 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:13 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:13 volumio volumio[3030]: info: ------------------------------ 44ms
Apr 16 21:39:13 volumio volumio[3030]: info: sendMpdCommand add "NAS/ds918/单曲/Jannik-Heart Linked.mp3" took 42 milliseconds
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand play
Apr 16 21:39:13 volumio volumio[3030]: info: ------------------------------ 13ms
Apr 16 21:39:13 volumio volumio[3030]: info: sendMpdCommand play took 13 milliseconds
Apr 16 21:39:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:13 volumio volumio[3030]: info:
Apr 16 21:39:13 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:13 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:13 volumio volumio[3030]: info:
Apr 16 21:39:13 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:13 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:13 volumio volumio[3030]: info: sendMpdCommand status took 2 milliseconds
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:13 volumio volumio[3030]: info: sendMpdCommand status took 2 milliseconds
Apr 16 21:39:13 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:13 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:13 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":230,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Heart Linked","artist":"Jannik","album":null,"uri":"NAS/ds918/单曲/Jannik-Heart Linked.mp3","trackType":"mp3"}
Apr 16 21:39:13 volumio volumio[3030]: verbose: CURRENT POSITION 40
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:13 volumio volumio[3030]: info: ------------------------------ 7ms
Apr 16 21:39:13 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:13 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:13 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:13 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":230,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Heart Linked","artist":"Jannik","album":null,"uri":"NAS/ds918/单曲/Jannik-Heart Linked.mp3","trackType":"mp3"}
Apr 16 21:39:13 volumio volumio[3030]: verbose: CURRENT POSITION 40
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus play
Apr 16 21:39:13 volumio volumio[3030]: info: Received an update from plugin. extracting info from payload
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:13 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:13 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:13 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:13 volumio volumio[3030]: info: ------------------------------ 31ms
Apr 16 21:39:15 volumio volumio[3030]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Apr 16 21:39:15 volumio volumio[3030]: info: Retrying Login Due to Network Error
Apr 16 21:39:17 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::volumioNext
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::next
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::stop
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::stPlaybackTimer
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::serviceStop
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 40
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::serviceStop
Apr 16 21:39:17 volumio volumio[3030]: info: ControllerMpd::stop
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:17 volumio volumio[3030]: info:
Apr 16 21:39:17 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:17 volumio volumio[3030]: info: sendMpdCommand stop took 17 milliseconds
Apr 16 21:39:17 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::play index undefined
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::startPlaybackTimer
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/单曲/Jax Jones - Yeah Yeah Yeah.mp3
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:17 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:17 volumio volumio[3030]: info: sendMpdCommand stop took 1 milliseconds
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand clear
Apr 16 21:39:17 volumio volumio[3030]: info:
Apr 16 21:39:17 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:17 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:17 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 16 21:39:17 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:17 volumio volumio[3030]: info: sendMpdCommand clear took 1 milliseconds
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/单曲/Jax Jones - Yeah Yeah Yeah.mp3"
Apr 16 21:39:17 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:17 volumio volumio[3030]: 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":"Heart Linked","artist":"Jannik","album":null,"uri":"NAS/ds918/单曲/Jannik-Heart Linked.mp3","trackType":"mp3"}
Apr 16 21:39:17 volumio volumio[3030]: verbose: CURRENT POSITION 41
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::syncState stateService stop
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:17 volumio volumio[3030]: info: No code
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:17 volumio volumio[3030]: info: ------------------------------ 36ms
Apr 16 21:39:17 volumio volumio[3030]: error: updateQueue error: null
Apr 16 21:39:17 volumio volumio[3030]: info:
Apr 16 21:39:17 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:17 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:17 volumio volumio[3030]: info: ------------------------------ 32ms
Apr 16 21:39:17 volumio volumio[3030]: info: sendMpdCommand add "NAS/ds918/单曲/Jax Jones - Yeah Yeah Yeah.mp3" took 31 milliseconds
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand play
Apr 16 21:39:17 volumio volumio[3030]: info: ------------------------------ 16ms
Apr 16 21:39:17 volumio volumio[3030]: info: sendMpdCommand play took 15 milliseconds
Apr 16 21:39:17 volumio volumio[3030]: info:
Apr 16 21:39:17 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:17 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:17 volumio volumio[3030]: info:
Apr 16 21:39:17 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:17 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:17 volumio volumio[3030]: info: sendMpdCommand status took 2 milliseconds
Apr 16 21:39:17 volumio volumio[3030]: info: sendMpdCommand status took 2 milliseconds
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:17 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:17 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:17 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:17 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:17 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":301,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jax Jones - Yeah Yeah Yeah.mp3","artist":null,"album":null,"uri":"NAS/ds918/单曲/Jax Jones - Yeah Yeah Yeah.mp3","trackType":"mp3"}
Apr 16 21:39:17 volumio volumio[3030]: verbose: CURRENT POSITION 41
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:17 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:17 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":301,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jax Jones - Yeah Yeah Yeah.mp3","artist":null,"album":null,"uri":"NAS/ds918/单曲/Jax Jones - Yeah Yeah Yeah.mp3","trackType":"mp3"}
Apr 16 21:39:17 volumio volumio[3030]: verbose: CURRENT POSITION 41
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:17 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus play
Apr 16 21:39:17 volumio volumio[3030]: info: Received an update from plugin. extracting info from payload
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:17 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:17 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:17 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:17 volumio volumio[3030]: info: ------------------------------ 18ms
Apr 16 21:39:17 volumio volumio[3030]: info: ------------------------------ 35ms
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::volumioNext
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::next
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::stop
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::stPlaybackTimer
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::serviceStop
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 41
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::serviceStop
Apr 16 21:39:20 volumio volumio[3030]: info: ControllerMpd::stop
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:20 volumio volumio[3030]: info:
Apr 16 21:39:20 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:20 volumio volumio[3030]: info: sendMpdCommand stop took 15 milliseconds
Apr 16 21:39:20 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::play index undefined
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::startPlaybackTimer
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/单曲/Lost Frequencies-Are You With Me(Radio Edit).wav
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:20 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:20 volumio volumio[3030]: info: sendMpdCommand stop took 2 milliseconds
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand clear
Apr 16 21:39:20 volumio volumio[3030]: info:
Apr 16 21:39:20 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:20 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:20 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:20 volumio volumio[3030]: info: sendMpdCommand clear took 2 milliseconds
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/单曲/Lost Frequencies-Are You With Me(Radio Edit).wav"
Apr 16 21:39:20 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:20 volumio volumio[3030]: 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":"Jax Jones - Yeah Yeah Yeah.mp3","artist":null,"album":null,"uri":"NAS/ds918/单曲/Jax Jones - Yeah Yeah Yeah.mp3","trackType":"mp3"}
Apr 16 21:39:20 volumio volumio[3030]: verbose: CURRENT POSITION 42
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::syncState stateService stop
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:20 volumio volumio[3030]: info: No code
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:20 volumio volumio[3030]: info: ------------------------------ 36ms
Apr 16 21:39:20 volumio volumio[3030]: error: updateQueue error: null
Apr 16 21:39:20 volumio volumio[3030]: info:
Apr 16 21:39:20 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:20 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:20 volumio volumio[3030]: info: ------------------------------ 32ms
Apr 16 21:39:20 volumio volumio[3030]: info: sendMpdCommand add "NAS/ds918/单曲/Lost Frequencies-Are You With Me(Radio Edit).wav" took 30 milliseconds
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand play
Apr 16 21:39:20 volumio volumio[3030]: info: ------------------------------ 13ms
Apr 16 21:39:20 volumio volumio[3030]: info: sendMpdCommand play took 12 milliseconds
Apr 16 21:39:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:20 volumio volumio[3030]: info:
Apr 16 21:39:20 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:20 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:20 volumio volumio[3030]: info:
Apr 16 21:39:20 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:20 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:20 volumio volumio[3030]: info: sendMpdCommand status took 2 milliseconds
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:20 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:20 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:20 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:20 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lost Frequencies-Are You With Me(Radio Edit).wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/Lost Frequencies-Are You With Me(Radio Edit).wav","trackType":"wav"}
Apr 16 21:39:20 volumio volumio[3030]: verbose: CURRENT POSITION 42
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:20 volumio volumio[3030]: info: ------------------------------ 8ms
Apr 16 21:39:20 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:20 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:20 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:20 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lost Frequencies-Are You With Me(Radio Edit).wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/Lost Frequencies-Are You With Me(Radio Edit).wav","trackType":"wav"}
Apr 16 21:39:20 volumio volumio[3030]: verbose: CURRENT POSITION 42
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus play
Apr 16 21:39:20 volumio volumio[3030]: info: Received an update from plugin. extracting info from payload
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:20 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:20 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:20 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:20 volumio volumio[3030]: info: ------------------------------ 29ms
Apr 16 21:39:23 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::volumioGetState
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:23 volumio volumio[3030]: info: Listing playlists
Apr 16 21:39:23 volumio volumio[3030]: info: Listing playlists
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::volumioNext
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::next
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::stop
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::stPlaybackTimer
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::serviceStop
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 42
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::serviceStop
Apr 16 21:39:23 volumio volumio[3030]: info: ControllerMpd::stop
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:23 volumio volumio[3030]: info:
Apr 16 21:39:23 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:23 volumio volumio[3030]: info: sendMpdCommand stop took 25 milliseconds
Apr 16 21:39:23 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::play index undefined
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::startPlaybackTimer
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/单曲/MKJ - Time.flac
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:23 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:23 volumio volumio[3030]: info: sendMpdCommand stop took 1 milliseconds
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand clear
Apr 16 21:39:23 volumio volumio[3030]: info:
Apr 16 21:39:23 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:23 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:23 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 16 21:39:23 volumio volumio[3030]: info: sendMpdCommand clear took 2 milliseconds
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/单曲/MKJ - Time.flac"
Apr 16 21:39:23 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:23 volumio volumio[3030]: 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":"Lost Frequencies-Are You With Me(Radio Edit).wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/Lost Frequencies-Are You With Me(Radio Edit).wav","trackType":"wav"}
Apr 16 21:39:23 volumio volumio[3030]: verbose: CURRENT POSITION 43
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::syncState stateService stop
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:23 volumio volumio[3030]: info: No code
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:23 volumio volumio[3030]: info: ------------------------------ 40ms
Apr 16 21:39:23 volumio volumio[3030]: error: updateQueue error: null
Apr 16 21:39:23 volumio volumio[3030]: info:
Apr 16 21:39:23 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:23 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:23 volumio volumio[3030]: info: ------------------------------ 35ms
Apr 16 21:39:23 volumio volumio[3030]: info: sendMpdCommand add "NAS/ds918/单曲/MKJ - Time.flac" took 35 milliseconds
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand play
Apr 16 21:39:23 volumio volumio[3030]: info: ------------------------------ 16ms
Apr 16 21:39:23 volumio volumio[3030]: info: sendMpdCommand play took 15 milliseconds
Apr 16 21:39:23 volumio volumio[3030]: info:
Apr 16 21:39:23 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:23 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:23 volumio volumio[3030]: info:
Apr 16 21:39:23 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:23 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:23 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:23 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:23 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:23 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:23 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"MKJ - Time.flac","artist":null,"album":null,"uri":"NAS/ds918/单曲/MKJ - Time.flac","trackType":"flac"}
Apr 16 21:39:23 volumio volumio[3030]: verbose: CURRENT POSITION 43
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:23 volumio volumio[3030]: info: ------------------------------ 13ms
Apr 16 21:39:23 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 16 21:39:23 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:23 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:23 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"MKJ - Time.flac","artist":null,"album":null,"uri":"NAS/ds918/单曲/MKJ - Time.flac","trackType":"flac"}
Apr 16 21:39:23 volumio volumio[3030]: verbose: CURRENT POSITION 43
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus play
Apr 16 21:39:23 volumio volumio[3030]: info: Received an update from plugin. extracting info from payload
Apr 16 21:39:23 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:23 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:23 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:24 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:24 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:24 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:24 volumio volumio[3030]: info: ------------------------------ 49ms
Apr 16 21:39:25 volumio volumio[3030]: info: MyVolumio login type: Token
Apr 16 21:39:25 volumio volumio[3030]: info: CoreCommandRouter::volumioNext
Apr 16 21:39:25 volumio volumio[3030]: info: CoreStateMachine::next
Apr 16 21:39:25 volumio volumio[3030]: info: CoreStateMachine::stop
Apr 16 21:39:25 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:25 volumio volumio[3030]: info: CoreStateMachine::stPlaybackTimer
Apr 16 21:39:25 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:25 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:25 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:25 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:25 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:25 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::serviceStop
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrack 43
Apr 16 21:39:26 volumio volumio[3030]: info: CoreCommandRouter::serviceStop
Apr 16 21:39:26 volumio volumio[3030]: info: ControllerMpd::stop
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:26 volumio volumio[3030]: info:
Apr 16 21:39:26 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:26 volumio volumio[3030]: info: sendMpdCommand stop took 82 milliseconds
Apr 16 21:39:26 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:26 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::play index undefined
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::startPlaybackTimer
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/单曲/MKJ-Time.wav
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:26 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:26 volumio volumio[3030]: info: sendMpdCommand stop took 2 milliseconds
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand clear
Apr 16 21:39:26 volumio volumio[3030]: info:
Apr 16 21:39:26 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:26 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:26 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:26 volumio volumio[3030]: info: sendMpdCommand clear took 2 milliseconds
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/单曲/MKJ-Time.wav"
Apr 16 21:39:26 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:26 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:26 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:26 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:26 volumio volumio[3030]: 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":"MKJ - Time.flac","artist":null,"album":null,"uri":"NAS/ds918/单曲/MKJ - Time.flac","trackType":"flac"}
Apr 16 21:39:26 volumio volumio[3030]: verbose: CURRENT POSITION 44
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::syncState stateService stop
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:26 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:26 volumio volumio[3030]: info: No code
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:26 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:26 volumio volumio[3030]: info: ------------------------------ 37ms
Apr 16 21:39:26 volumio volumio[3030]: error: updateQueue error: null
Apr 16 21:39:26 volumio volumio[3030]: info:
Apr 16 21:39:26 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:26 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:26 volumio volumio[3030]: info: ------------------------------ 33ms
Apr 16 21:39:26 volumio volumio[3030]: info: sendMpdCommand add "NAS/ds918/单曲/MKJ-Time.wav" took 31 milliseconds
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand play
Apr 16 21:39:26 volumio volumio[3030]: info: ------------------------------ 11ms
Apr 16 21:39:26 volumio volumio[3030]: info: sendMpdCommand play took 11 milliseconds
Apr 16 21:39:26 volumio volumio[3030]: info:
Apr 16 21:39:26 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:26 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:26 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:26 volumio volumio[3030]: info:
Apr 16 21:39:26 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:26 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:26 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:26 volumio volumio[3030]: info: sendMpdCommand status took 2 milliseconds
Apr 16 21:39:26 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:26 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:26 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:26 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"MKJ-Time.wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/MKJ-Time.wav","trackType":"wav"}
Apr 16 21:39:26 volumio volumio[3030]: verbose: CURRENT POSITION 44
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:26 volumio volumio[3030]: info: ------------------------------ 10ms
Apr 16 21:39:26 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 16 21:39:26 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:26 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:26 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:26 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"MKJ-Time.wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/MKJ-Time.wav","trackType":"wav"}
Apr 16 21:39:26 volumio volumio[3030]: verbose: CURRENT POSITION 44
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus play
Apr 16 21:39:26 volumio volumio[3030]: info: Received an update from plugin. extracting info from payload
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:26 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:26 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:26 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:26 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:26 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:26 volumio volumio[3030]: info: ------------------------------ 31ms
Apr 16 21:39:27 volumio volumio[3030]: info: CoreCommandRouter::volumioNext
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::next
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::stop
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::stPlaybackTimer
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:27 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:27 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:27 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:27 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::serviceStop
Apr 16 21:39:27 volumio volumio[3030]: info: CorePlayQueue::getTrack 44
Apr 16 21:39:27 volumio volumio[3030]: info: CoreCommandRouter::serviceStop
Apr 16 21:39:27 volumio volumio[3030]: info: ControllerMpd::stop
Apr 16 21:39:27 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:27 volumio volumio[3030]: info:
Apr 16 21:39:27 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:27 volumio volumio[3030]: info: sendMpdCommand stop took 93 milliseconds
Apr 16 21:39:27 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:27 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::play index undefined
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:27 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::startPlaybackTimer
Apr 16 21:39:27 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:27 volumio volumio[3030]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/单曲/Nevada(Original_Mix)-Vicetone_Cozi_Zuehlsdorff-7171062.flac
Apr 16 21:39:27 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:27 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:27 volumio volumio[3030]: info: sendMpdCommand status took 5 milliseconds
Apr 16 21:39:27 volumio volumio[3030]: info: sendMpdCommand stop took 2 milliseconds
Apr 16 21:39:27 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:27 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:27 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand clear
Apr 16 21:39:27 volumio volumio[3030]: info:
Apr 16 21:39:27 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:27 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:27 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:27 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:27 volumio volumio[3030]: info: sendMpdCommand clear took 2 milliseconds
Apr 16 21:39:27 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:27 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/单曲/Nevada(Original_Mix)-Vicetone_Cozi_Zuehlsdorff-7171062.flac"
Apr 16 21:39:27 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:27 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:27 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:27 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:27 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:27 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:27 volumio volumio[3030]: 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":"MKJ-Time.wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/MKJ-Time.wav","trackType":"wav"}
Apr 16 21:39:27 volumio volumio[3030]: verbose: CURRENT POSITION 45
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::syncState stateService stop
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:27 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:27 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:27 volumio volumio[3030]: info: No code
Apr 16 21:39:27 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:27 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:27 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:27 volumio volumio[3030]: info: ------------------------------ 56ms
Apr 16 21:39:27 volumio volumio[3030]: error: updateQueue error: null
Apr 16 21:39:27 volumio volumio[3030]: info:
Apr 16 21:39:27 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:27 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:27 volumio volumio[3030]: info: ------------------------------ 52ms
Apr 16 21:39:27 volumio volumio[3030]: info: sendMpdCommand add "NAS/ds918/单曲/Nevada(Original_Mix)-Vicetone_Cozi_Zuehlsdorff-7171062.flac" took 52 milliseconds
Apr 16 21:39:27 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand play
Apr 16 21:39:27 volumio volumio[3030]: info: ------------------------------ 16ms
Apr 16 21:39:27 volumio volumio[3030]: info: sendMpdCommand play took 14 milliseconds
Apr 16 21:39:27 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:28 volumio volumio[3030]: info:
Apr 16 21:39:28 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:28 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:28 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:28 volumio volumio[3030]: info:
Apr 16 21:39:28 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:28 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:28 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:28 volumio volumio[3030]: info: sendMpdCommand status took 4 milliseconds
Apr 16 21:39:28 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:28 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:28 volumio volumio[3030]: info: sendMpdCommand status took 4 milliseconds
Apr 16 21:39:28 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 16 21:39:28 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:28 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:28 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:28 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:28 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:28 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:28 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":209,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"440 Kbps","isStreaming":false,"title":"Nevada(Original Mix)","artist":"Vicetone&Cozi Zuehlsdorff","album":null,"uri":"NAS/ds918/单曲/Nevada(Original_Mix)-Vicetone_Cozi_Zuehlsdorff-7171062.flac","trackType":"flac"}
Apr 16 21:39:28 volumio volumio[3030]: verbose: CURRENT POSITION 45
Apr 16 21:39:28 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:28 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:28 volumio volumio[3030]: info: ------------------------------ 11ms
Apr 16 21:39:28 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 37 milliseconds
Apr 16 21:39:28 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:28 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:28 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:28 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:28 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":209,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"440 Kbps","isStreaming":false,"title":"Nevada(Original Mix)","artist":"Vicetone&Cozi Zuehlsdorff","album":null,"uri":"NAS/ds918/单曲/Nevada(Original_Mix)-Vicetone_Cozi_Zuehlsdorff-7171062.flac","trackType":"flac"}
Apr 16 21:39:28 volumio volumio[3030]: verbose: CURRENT POSITION 45
Apr 16 21:39:28 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:28 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus play
Apr 16 21:39:28 volumio volumio[3030]: info: Received an update from plugin. extracting info from payload
Apr 16 21:39:28 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:28 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:28 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:28 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:28 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:28 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:28 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:28 volumio volumio[3030]: info: ------------------------------ 69ms
Apr 16 21:39:28 volumio wpa_supplicant[724]: wlan0: Failed to initiate sched scan
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::volumioNext
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::next
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::stop
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::stPlaybackTimer
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::serviceStop
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 45
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::serviceStop
Apr 16 21:39:30 volumio volumio[3030]: info: ControllerMpd::stop
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:30 volumio volumio[3030]: info:
Apr 16 21:39:30 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:30 volumio volumio[3030]: info: sendMpdCommand stop took 86 milliseconds
Apr 16 21:39:30 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:30 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::play index undefined
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::startPlaybackTimer
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/单曲/Ninghtingale(夜莺).wav
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:30 volumio volumio[3030]: info: sendMpdCommand status took 6 milliseconds
Apr 16 21:39:30 volumio volumio[3030]: info: sendMpdCommand stop took 4 milliseconds
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand clear
Apr 16 21:39:30 volumio volumio[3030]: info:
Apr 16 21:39:30 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:30 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:30 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 16 21:39:30 volumio volumio[3030]: info: sendMpdCommand clear took 6 milliseconds
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/单曲/Ninghtingale(夜莺).wav"
Apr 16 21:39:30 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:30 volumio volumio[3030]: 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":"Nevada(Original Mix)","artist":"Vicetone&Cozi Zuehlsdorff","album":null,"uri":"NAS/ds918/单曲/Nevada(Original_Mix)-Vicetone_Cozi_Zuehlsdorff-7171062.flac","trackType":"flac"}
Apr 16 21:39:30 volumio volumio[3030]: verbose: CURRENT POSITION 46
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::syncState stateService stop
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:30 volumio volumio[3030]: info: No code
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:30 volumio volumio[3030]: info: ------------------------------ 66ms
Apr 16 21:39:30 volumio volumio[3030]: error: updateQueue error: null
Apr 16 21:39:30 volumio volumio[3030]: info:
Apr 16 21:39:30 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:30 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:30 volumio volumio[3030]: info: ------------------------------ 58ms
Apr 16 21:39:30 volumio volumio[3030]: info: sendMpdCommand add "NAS/ds918/单曲/Ninghtingale(夜莺).wav" took 57 milliseconds
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand play
Apr 16 21:39:30 volumio volumio[3030]: info: ------------------------------ 26ms
Apr 16 21:39:30 volumio volumio[3030]: info: sendMpdCommand play took 23 milliseconds
Apr 16 21:39:30 volumio volumio[3030]: info:
Apr 16 21:39:30 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:30 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:30 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:30 volumio volumio[3030]: info:
Apr 16 21:39:30 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:30 volumio volumio[3030]: info: sendMpdCommand status took 7 milliseconds
Apr 16 21:39:30 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:30 volumio volumio[3030]: info: sendMpdCommand status took 4 milliseconds
Apr 16 21:39:30 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:30 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:30 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ninghtingale(夜莺).wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/Ninghtingale(夜莺).wav","trackType":"wav"}
Apr 16 21:39:30 volumio volumio[3030]: verbose: CURRENT POSITION 46
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:30 volumio volumio[3030]: info: ------------------------------ 23ms
Apr 16 21:39:30 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 16 21:39:30 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:30 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:30 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ninghtingale(夜莺).wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/Ninghtingale(夜莺).wav","trackType":"wav"}
Apr 16 21:39:30 volumio volumio[3030]: verbose: CURRENT POSITION 46
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus play
Apr 16 21:39:30 volumio volumio[3030]: info: Received an update from plugin. extracting info from payload
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:30 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:30 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:30 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:30 volumio volumio[3030]: info: ------------------------------ 47ms
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::volumioNext
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::next
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::stop
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::stPlaybackTimer
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::serviceStop
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 46
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::serviceStop
Apr 16 21:39:32 volumio volumio[3030]: info: ControllerMpd::stop
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:32 volumio volumio[3030]: info:
Apr 16 21:39:32 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:32 volumio volumio[3030]: info: sendMpdCommand stop took 69 milliseconds
Apr 16 21:39:32 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::play index undefined
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 47
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::startPlaybackTimer
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 47
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/单曲/Pascal Letoublon-Friendships(Original Mix)(Remix).wav
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand stop
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::updateTrackBlock
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrackBlock
Apr 16 21:39:32 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:32 volumio volumio[3030]: info: sendMpdCommand stop took 1 milliseconds
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand clear
Apr 16 21:39:32 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:32 volumio volumio[3030]: info:
Apr 16 21:39:32 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:32 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:32 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:32 volumio volumio[3030]: info: sendMpdCommand clear took 2 milliseconds
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/单曲/Pascal Letoublon-Friendships(Original Mix)(Remix).wav"
Apr 16 21:39:32 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 47
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 47
Apr 16 21:39:32 volumio volumio[3030]: 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":"Ninghtingale(夜莺).wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/Ninghtingale(夜莺).wav","trackType":"wav"}
Apr 16 21:39:32 volumio volumio[3030]: verbose: CURRENT POSITION 47
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::syncState stateService stop
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 47
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:32 volumio volumio[3030]: info: No code
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 47
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:32 volumio volumio[3030]: info: ------------------------------ 36ms
Apr 16 21:39:32 volumio volumio[3030]: error: updateQueue error: null
Apr 16 21:39:32 volumio volumio[3030]: info:
Apr 16 21:39:32 volumio volumio[3030]: ---------------------------- MPD announces system playlist update
Apr 16 21:39:32 volumio volumio[3030]: info: Ignoring MPD Status Update
Apr 16 21:39:32 volumio volumio[3030]: info: ------------------------------ 32ms
Apr 16 21:39:32 volumio volumio[3030]: info: sendMpdCommand add "NAS/ds918/单曲/Pascal Letoublon-Friendships(Original Mix)(Remix).wav" took 31 milliseconds
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand play
Apr 16 21:39:32 volumio volumio[3030]: info: ------------------------------ 12ms
Apr 16 21:39:32 volumio volumio[3030]: info: sendMpdCommand play took 11 milliseconds
Apr 16 21:39:32 volumio volumio[3030]: info:
Apr 16 21:39:32 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:32 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:32 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121
Apr 16 21:39:32 volumio volumio[3030]: info:
Apr 16 21:39:32 volumio volumio[3030]: ---------------------------- MPD announces state update: player
Apr 16 21:39:32 volumio volumio[3030]: info: sendMpdCommand status took 4 milliseconds
Apr 16 21:39:32 volumio volumio[3030]: info: ControllerMpd::getState
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand status
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:32 volumio volumio[3030]: info: sendMpdCommand status took 3 milliseconds
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::parseState
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 16 21:39:32 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 16 21:39:32 volumio volumio[3030]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:32 volumio volumio[3030]: verbose: ControllerMpd::parseTrackInfo
Apr 16 21:39:32 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 47
Apr 16 21:39:32 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Pascal Letoublon-Friendships(Original Mix)(Remix).wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/Pascal Letoublon-Friendships(Original Mix)(Remix).wav","trackType":"wav"}
Apr 16 21:39:32 volumio volumio[3030]: verbose: CURRENT POSITION 47
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus stop
Apr 16 21:39:32 volumio volumio[3030]: info: ControllerMpd::pushState
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::servicePushState
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 47
Apr 16 21:39:32 volumio volumio[3030]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Pascal Letoublon-Friendships(Original Mix)(Remix).wav","artist":null,"album":null,"uri":"NAS/ds918/单曲/Pascal Letoublon-Friendships(Original Mix)(Remix).wav","trackType":"wav"}
Apr 16 21:39:32 volumio volumio[3030]: verbose: CURRENT POSITION 47
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::syncState stateService play
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::syncState currentStatus play
Apr 16 21:39:32 volumio volumio[3030]: info: Received an update from plugin. extracting info from payload
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 47
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:32 volumio volumio[3030]: info: CoreStateMachine::pushState
Apr 16 21:39:32 volumio volumio[3030]: info: CorePlayQueue::getTrack 47
Apr 16 21:39:32 volumio volumio[3030]: info: CoreCommandRouter::volumioPushState
Apr 16 21:39:32 volumio volumio[3030]: info: ------------------------------ 23ms
Apr 16 21:39:32 volumio volumio[3030]: info: ------------------------------ 34ms
Apr 16 21:39:33 volumio volumio[3030]: info: CoreCommandRouter::volumioGetState
Apr 16 21:39:33 volumio volumio[3030]: info: CorePlayQueue::getTrack 47
Apr 16 21:39:33 volumio volumio[3030]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 16 21:39:33 volumio volumio[3030]: Error: connect ETIMEDOUT 108.160.169.55:80
Apr 16 21:39:33 volumio volumio[3030]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Apr 16 21:39:33 volumio volumio[3030]: errno: -110,
Apr 16 21:39:33 volumio volumio[3030]: code: 'ETIMEDOUT',
Apr 16 21:39:33 volumio volumio[3030]: syscall: 'connect',
Apr 16 21:39:33 volumio volumio[3030]: address: '108.160.169.55',
Apr 16 21:39:33 volumio volumio[3030]: port: 80
Apr 16 21:39:33 volumio volumio[3030]: }
Apr 16 21:39:33 volumio volumio[3030]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 16 21:39:33 volumio sudo[3302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-16 21:38
Apr 16 21:39:33 volumio sudo[3302]: 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="c87c6e2b1ae33dc5801986cbcbe970898b92e7b4"
VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463"
VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7"
VOLUMIO_BE_VERSION="b949d6001d7e656b4668f31c119d2247cdf45158"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 30 Mar 2023 05:45:03 PM CEST"
VOLUMIO_VERSION="3.449"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="6428d8e2c06e98483f5c5d77e8f01989"