-- Logs begin at Thu 2024-05-09 07:08:15 UTC, end at Thu 2024-05-09 07:12:01 UTC. --
May 09 07:11:00 volumio volumio[800]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 10
May 09 07:11:00 volumio volumio[800]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 11
May 09 07:11:00 volumio volumio[800]: info: CoreCommandRouter::volumioGetState
May 09 07:11:00 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::volumioNext
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::next
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::stop
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::stPlaybackTimer
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::updateTrackBlock
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrackBlock
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::serviceStop
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::serviceStop
May 09 07:11:11 volumio volumio[800]: info: ControllerMpd::stop
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand stop
May 09 07:11:11 volumio volumio[800]: info: sendMpdCommand stop took 18 milliseconds
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::play index undefined
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::startPlaybackTimer
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/吕方 - 你的浅笑.wav
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand stop
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::updateTrackBlock
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrackBlock
May 09 07:11:11 volumio volumio[800]: info:
May 09 07:11:11 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:11 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:11 volumio volumio[800]: info: sendMpdCommand stop took 1 milliseconds
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand clear
May 09 07:11:11 volumio volumio[800]: info:
May 09 07:11:11 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:11 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:11 volumio volumio[800]: info:
May 09 07:11:11 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:11 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:11 volumio volumio[800]: info:
May 09 07:11:11 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:11 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:11 volumio volumio[800]: info:
May 09 07:11:11 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:11 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:11 volumio volumio[800]: info: sendMpdCommand status took 3 milliseconds
May 09 07:11:11 volumio volumio[800]: info: sendMpdCommand clear took 2 milliseconds
May 09 07:11:11 volumio volumio[800]: info: sendMpdCommand status took 2 milliseconds
May 09 07:11:11 volumio volumio[800]: info: sendMpdCommand status took 2 milliseconds
May 09 07:11:11 volumio volumio[800]: info: sendMpdCommand status took 2 milliseconds
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/吕方 - 你的浅笑.wav"
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:11 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:11 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 09 07:11:11 volumio volumio[800]: verbose: CURRENT POSITION 0
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::syncState stateService stop
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:11 volumio volumio[800]: info: No code
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:11 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 09 07:11:11 volumio volumio[800]: verbose: CURRENT POSITION 0
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::syncState stateService stop
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:11 volumio volumio[800]: info: No code
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:11 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 09 07:11:11 volumio volumio[800]: verbose: CURRENT POSITION 0
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::syncState stateService stop
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:11 volumio volumio[800]: info: No code
May 09 07:11:11 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:11 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:11 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 75ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 74ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 75ms
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:12 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:12 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:12 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:12 volumio volumio[800]: error: updateQueue error: null
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:12 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 76ms
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand playlistinfo took 75 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand add "INTERNAL/吕方 - 你的浅笑.wav" took 76 milliseconds
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 3ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 2ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 2ms
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand play
May 09 07:11:12 volumio volumio[800]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 81ms
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:12 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:12 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:12 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 17ms
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand play took 15 milliseconds
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 15ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 13ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 12ms
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand status took 3 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand status took 2 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand status took 1 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand status took 2 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand status took 1 milliseconds
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:12 volumio volumio[800]: info:
May 09 07:11:12 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand status took 3 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand status took 2 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand status took 1 milliseconds
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"吕方 - 你的浅笑.wav","artist":null,"album":null,"uri":"INTERNAL/吕方 - 你的浅笑.wav","trackType":"wav"}
May 09 07:11:12 volumio volumio[800]: verbose: CURRENT POSITION 0
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"吕方 - 你的浅笑.wav","artist":null,"album":null,"uri":"INTERNAL/吕方 - 你的浅笑.wav","trackType":"wav"}
May 09 07:11:12 volumio volumio[800]: verbose: CURRENT POSITION 0
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:12 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"吕方 - 你的浅笑.wav","artist":null,"album":null,"uri":"INTERNAL/吕方 - 你的浅笑.wav","trackType":"wav"}
May 09 07:11:12 volumio volumio[800]: verbose: CURRENT POSITION 0
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:12 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"吕方 - 你的浅笑.wav","artist":null,"album":null,"uri":"INTERNAL/吕方 - 你的浅笑.wav","trackType":"wav"}
May 09 07:11:12 volumio volumio[800]: verbose: CURRENT POSITION 0
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:12 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"吕方 - 你的浅笑.wav","artist":null,"album":null,"uri":"INTERNAL/吕方 - 你的浅笑.wav","trackType":"wav"}
May 09 07:11:12 volumio volumio[800]: verbose: CURRENT POSITION 0
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:12 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 22ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 73ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 72ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 71ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 72ms
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand playlistinfo took 66 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand playlistinfo took 65 milliseconds
May 09 07:11:12 volumio volumio[800]: info: sendMpdCommand playlistinfo took 65 milliseconds
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:12 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"吕方 - 你的浅笑.wav","artist":null,"album":null,"uri":"INTERNAL/吕方 - 你的浅笑.wav","trackType":"wav"}
May 09 07:11:12 volumio volumio[800]: verbose: CURRENT POSITION 0
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:12 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"吕方 - 你的浅笑.wav","artist":null,"album":null,"uri":"INTERNAL/吕方 - 你的浅笑.wav","trackType":"wav"}
May 09 07:11:12 volumio volumio[800]: verbose: CURRENT POSITION 0
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:12 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"吕方 - 你的浅笑.wav","artist":null,"album":null,"uri":"INTERNAL/吕方 - 你的浅笑.wav","trackType":"wav"}
May 09 07:11:12 volumio volumio[800]: verbose: CURRENT POSITION 0
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:12 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:12 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:12 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 108ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 107ms
May 09 07:11:12 volumio volumio[800]: info: ------------------------------ 108ms
May 09 07:11:18 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 09 07:11:18 volumio volumio[800]: info: CURURI: music-library/USB
May 09 07:11:18 volumio volumio[800]: info: Preload queue cleared
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 09 07:11:19 volumio volumio[800]: info: CURURI: music-library/USB/CE2EE83FF80E51B4
May 09 07:11:19 volumio volumio[800]: info: Preload queue cleared
May 09 07:11:19 volumio volumio[800]: info: Preload queue cleared
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::ClearQueue
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::stop
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::stPlaybackTimer
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::updateTrackBlock
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrackBlock
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::serviceStop
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 0
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::serviceStop
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::stop
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand stop
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::clearPlayQueue
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::saveQueue
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushQueue
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::addQueueItems
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::addQueueItems
May 09 07:11:19 volumio volumio[800]: info: Preload queue cleared
May 09 07:11:19 volumio volumio[800]: info: Adding Item to queue: music-library/USB/CE2EE83FF80E51B4/06 千載不變.wav
May 09 07:11:19 volumio volumio[800]: info: Using cached record of: music-library/USB/CE2EE83FF80E51B4/06 千載不變.wav
May 09 07:11:19 volumio volumio[800]: info: Adding Item to queue: music-library/USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav
May 09 07:11:19 volumio volumio[800]: info: Using cached record of: music-library/USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushQueue
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::saveQueue
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::updateTrackBlock
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrackBlock
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPlay
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::play index 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::stop
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::play index undefined
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::startPlaybackTimer
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::clearAddPlayTracks USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand stop
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand stop took 23 milliseconds
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand stop took 4 milliseconds
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand clear
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:19 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 3 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand clear took 3 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 2 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 2 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 1 milliseconds
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand add "USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav"
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 09 07:11:19 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState stateService stop
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: No code
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 09 07:11:19 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState stateService stop
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: No code
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 09 07:11:19 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState stateService stop
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: No code
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 68ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 68ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 68ms
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:19 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:19 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:19 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:19 volumio volumio[800]: error: updateQueue error: null
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:19 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 70ms
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand playlistinfo took 69 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand add "USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav" took 69 milliseconds
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 3ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 2ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 2ms
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand play
May 09 07:11:19 volumio volumio[800]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 74ms
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:19 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:19 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:19 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 21ms
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand play took 19 milliseconds
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 20ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 19ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 19ms
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 3 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 3 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 1 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 1 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 1 milliseconds
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info:
May 09 07:11:19 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 2 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 2 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand status took 1 milliseconds
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":762,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:19 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":762,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:19 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:19 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":762,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:19 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:19 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":762,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:19 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:19 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":762,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:19 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:19 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 25ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 62ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 60ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 60ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 60ms
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand playlistinfo took 56 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand playlistinfo took 55 milliseconds
May 09 07:11:19 volumio volumio[800]: info: sendMpdCommand playlistinfo took 55 milliseconds
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:19 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":762,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:19 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:19 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":762,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:19 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:19 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":762,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:19 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:19 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:19 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:19 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 102ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 101ms
May 09 07:11:19 volumio volumio[800]: info: ------------------------------ 101ms
May 09 07:11:19 volumio volumio[800]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%AD%90%E7%A5%A5/1a1ab959-a6e4-42cd-939d-5b800c46deba.jpg'
May 09 07:11:22 volumio volumio[800]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 12
May 09 07:11:22 volumio volumio[800]: info: CoreCommandRouter::volumioGetState
May 09 07:11:22 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:23 volumio volumio[800]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 12
May 09 07:11:23 volumio volumio[800]: info: CoreCommandRouter::volumioGetState
May 09 07:11:23 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:23 volumio volumio[800]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%AD%90%E7%A5%A5/1a1ab959-a6e4-42cd-939d-5b800c46deba.jpg'
May 09 07:11:36 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 09 07:11:37 volumio volumio[800]: info: CoreCommandRouter::Close All Modals sent
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::stop
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::stPlaybackTimer
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::updateTrackBlock
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrackBlock
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::serviceStop
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::serviceStop
May 09 07:11:39 volumio volumio[800]: info: ControllerMpd::stop
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand stop
May 09 07:11:39 volumio volumio[800]: info: Disabling plugin peppy_screensaver
May 09 07:11:39 volumio volumio[800]: info: Preparing to generate the ALSA configuration file
May 09 07:11:39 volumio volumio[800]: info:
May 09 07:11:39 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:39 volumio volumio[800]: info: sendMpdCommand stop took 18 milliseconds
May 09 07:11:39 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:39 volumio volumio[800]: info:
May 09 07:11:39 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:39 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:39 volumio volumio[800]: info:
May 09 07:11:39 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:39 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:39 volumio volumio[800]: info:
May 09 07:11:39 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:39 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:39 volumio volumio[800]: info: sendMpdCommand status took 18 milliseconds
May 09 07:11:39 volumio volumio[800]: info: sendMpdCommand status took 1 milliseconds
May 09 07:11:39 volumio volumio[800]: info: sendMpdCommand status took 1 milliseconds
May 09 07:11:39 volumio volumio[800]: info: sendMpdCommand status took 1 milliseconds
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:39 volumio volumio[800]: info: Asound.conf file written
May 09 07:11:39 volumio sudo[2225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl
May 09 07:11:39 volumio sudo[2225]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 07:11:39 volumio sudo[2225]: pam_unix(sudo:session): session closed for user root
May 09 07:11:39 volumio systemd[1]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded.
May 09 07:11:39 volumio sudo[2228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
May 09 07:11:39 volumio sudo[2228]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 07:11:39 volumio sudo[2228]: pam_unix(sudo:session): session closed for user root
May 09 07:11:39 volumio volumio[800]: info: Output device has changed, restarting MPD
May 09 07:11:39 volumio sudo[2233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 09 07:11:39 volumio sudo[2233]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 07:11:39 volumio volumio[800]: info: Output device has changed, restarting Shairport Sync
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 09 07:11:39 volumio sudo[2233]: pam_unix(sudo:session): session closed for user root
May 09 07:11:39 volumio sudo[2236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 09 07:11:39 volumio sudo[2236]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 07:11:39 volumio systemd[1]: Stopping Music Player Daemon...
May 09 07:11:39 volumio volumio[800]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 09 07:11:39 volumio volumio[800]: info: Done.
May 09 07:11:39 volumio volumio[800]: info: sendMpdCommand playlistinfo took 85 milliseconds
May 09 07:11:39 volumio volumio[800]: info: sendMpdCommand playlistinfo took 84 milliseconds
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:39 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:39 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:39 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::syncState stateService stop
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: No code
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:39 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::syncState stateService stop
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: No code
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:39 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::syncState stateService stop
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: No code
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:39 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::syncState stateService stop
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio volumio[800]: info: No code
May 09 07:11:39 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:39 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:39 volumio systemd[1]: mpd.service: Succeeded.
May 09 07:11:39 volumio systemd[1]: Stopped Music Player Daemon.
May 09 07:11:39 volumio systemd[1]: Starting Music Player Daemon...
May 09 07:11:39 volumio volumio[800]: info: ------------------------------ 207ms
May 09 07:11:39 volumio volumio[800]: info: ------------------------------ 191ms
May 09 07:11:39 volumio volumio[800]: info: ------------------------------ 190ms
May 09 07:11:39 volumio volumio[800]: info: ------------------------------ 191ms
May 09 07:11:39 volumio volumio[800]: info: MPD Permissions set
May 09 07:11:39 volumio volumio[800]: error: Upnp client error: Error: This socket has been ended by the other party
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: Starting Shairport Sync
May 09 07:11:39 volumio sudo[2251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 09 07:11:39 volumio sudo[2251]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 07:11:39 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 09 07:11:39 volumio systemd[1]: shairport-sync.service: Succeeded.
May 09 07:11:39 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 09 07:11:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 09 07:11:39 volumio sudo[2251]: pam_unix(sudo:session): session closed for user root
May 09 07:11:39 volumio volumio[800]: info: Shairport-Sync Started
May 09 07:11:39 volumio mpd[2241]: May 09 07:11 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 09 07:11:39 volumio systemd[1]: Started Music Player Daemon.
May 09 07:11:39 volumio sudo[2236]: pam_unix(sudo:session): session closed for user root
May 09 07:11:39 volumio volumio[800]: error: updateQueue error: null
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:39 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:42 volumio volumio[800]: info: Enabling plugin peppy_screensaver
May 09 07:11:42 volumio volumio[800]: info: Loading plugin "peppy_screensaver"...
May 09 07:11:42 volumio volumio[800]: info: Applying required configuration parameters for plugin peppy_screensaver
May 09 07:11:42 volumio volumio[800]: info: Preparing to generate the ALSA configuration file
May 09 07:11:42 volumio volumio[800]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
May 09 07:11:42 volumio volumio[800]: info: Reading ALSA contributions from plugins.
May 09 07:11:42 volumio volumio[800]: info: Asound.conf file written
May 09 07:11:42 volumio sudo[2261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
May 09 07:11:42 volumio sudo[2261]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 07:11:42 volumio sudo[2261]: pam_unix(sudo:session): session closed for user root
May 09 07:11:42 volumio volumio[800]: info: Output device has changed, restarting MPD
May 09 07:11:42 volumio volumio[800]: info: Output device has changed, restarting Shairport Sync
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 09 07:11:42 volumio sudo[2266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 09 07:11:42 volumio sudo[2266]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 07:11:42 volumio sudo[2266]: pam_unix(sudo:session): session closed for user root
May 09 07:11:42 volumio sudo[2268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 09 07:11:42 volumio sudo[2268]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 07:11:42 volumio systemd[1]: Stopping Music Player Daemon...
May 09 07:11:42 volumio volumio[800]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 09 07:11:42 volumio volumio[800]: info: PLUGIN START: peppy_screensaver
May 09 07:11:42 volumio systemd[1]: mpd.service: Succeeded.
May 09 07:11:42 volumio volumio[800]: info: Loading i18n strings for locale zh
May 09 07:11:42 volumio systemd[1]: Stopped Music Player Daemon.
May 09 07:11:42 volumio volumio[800]: info: /tmp/myfifo created
May 09 07:11:42 volumio volumio[800]: info: /tmp/myfifosa created
May 09 07:11:42 volumio systemd[1]: Starting Music Player Daemon...
May 09 07:11:42 volumio sudo[2280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0
May 09 07:11:42 volumio sudo[2280]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 07:11:42 volumio sudo[2280]: pam_unix(sudo:session): session closed for user root
May 09 07:11:42 volumio volumio[800]: info: snd-dummy loaded
May 09 07:11:42 volumio volumio[800]: info: Error: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
May 09 07:11:42 volumio volumio[800]: info: MPD Permissions set
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:42 volumio volumio[800]: info: Starting Shairport Sync
May 09 07:11:42 volumio sudo[2289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 09 07:11:42 volumio sudo[2289]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 07:11:42 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 09 07:11:42 volumio systemd[1]: shairport-sync.service: Succeeded.
May 09 07:11:42 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 09 07:11:42 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 09 07:11:42 volumio sudo[2289]: pam_unix(sudo:session): session closed for user root
May 09 07:11:42 volumio volumio[800]: info: Shairport-Sync Started
May 09 07:11:42 volumio mpd[2274]: May 09 07:11 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 09 07:11:42 volumio systemd[1]: Started Music Player Daemon.
May 09 07:11:42 volumio sudo[2268]: pam_unix(sudo:session): session closed for user root
May 09 07:11:42 volumio volumio[800]: error: updateQueue error: null
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:42 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 07:11:43 volumio volumio[800]: error: Upnp client error: Error: This socket has been ended by the other party
May 09 07:11:43 volumio volumio[800]: info: CoreCommandRouter::volumioPlay
May 09 07:11:43 volumio volumio[800]: info: CoreStateMachine::play index undefined
May 09 07:11:43 volumio volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined
May 09 07:11:43 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:43 volumio volumio[800]: info: CoreStateMachine::startPlaybackTimer
May 09 07:11:43 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::clearAddPlayTracks USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand stop
May 09 07:11:43 volumio volumio[800]: info: sendMpdCommand stop took 1 milliseconds
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand clear
May 09 07:11:43 volumio volumio[800]: info:
May 09 07:11:43 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:43 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:43 volumio volumio[800]: info: sendMpdCommand clear took 1 milliseconds
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand add "USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav"
May 09 07:11:43 volumio volumio[800]: error: updateQueue error: null
May 09 07:11:43 volumio volumio[800]: info:
May 09 07:11:43 volumio volumio[800]: ---------------------------- MPD announces system playlist update
May 09 07:11:43 volumio volumio[800]: info: Ignoring MPD Status Update
May 09 07:11:43 volumio volumio[800]: info: ------------------------------ 1ms
May 09 07:11:43 volumio volumio[800]: info: sendMpdCommand add "USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav" took 1 milliseconds
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand play
May 09 07:11:43 volumio volumio[800]: info: ------------------------------ 1ms
May 09 07:11:43 volumio volumio[800]: info: sendMpdCommand play took 1 milliseconds
May 09 07:11:43 volumio volumio[800]: info:
May 09 07:11:43 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:43 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:43 volumio volumio[800]: info:
May 09 07:11:43 volumio volumio[800]: ---------------------------- MPD announces state update: player
May 09 07:11:43 volumio volumio[800]: info: sendMpdCommand status took 21 milliseconds
May 09 07:11:43 volumio volumio[800]: info: ControllerMpd::getState
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand status
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:43 volumio volumio[800]: info: sendMpdCommand status took 0 milliseconds
May 09 07:11:43 volumio volumio[800]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::parseState
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:43 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:43 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:43 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:43 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":762,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:43 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:43 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:43 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus stop
May 09 07:11:43 volumio volumio[800]: info: ------------------------------ 24ms
May 09 07:11:43 volumio volumio[800]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 09 07:11:43 volumio volumio[800]: verbose: ControllerMpd::parseTrackInfo
May 09 07:11:43 volumio volumio[800]: info: ControllerMpd::pushState
May 09 07:11:43 volumio volumio[800]: info: CoreCommandRouter::servicePushState
May 09 07:11:43 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:43 volumio volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":762,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"街頭霸王榜","artist":"林子祥","album":null,"uri":"USB/CE2EE83FF80E51B4/06.01 街頭霸王榜.wav","trackType":"wav"}
May 09 07:11:43 volumio volumio[800]: verbose: CURRENT POSITION 1
May 09 07:11:43 volumio volumio[800]: info: CoreStateMachine::syncState stateService play
May 09 07:11:43 volumio volumio[800]: info: CoreStateMachine::syncState currentStatus play
May 09 07:11:43 volumio volumio[800]: info: Received an update from plugin. extracting info from payload
May 09 07:11:43 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:43 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:43 volumio volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 09 07:11:43 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:43 volumio volumio[800]: info: CoreStateMachine::pushState
May 09 07:11:43 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:43 volumio volumio[800]: info: CoreCommandRouter::volumioPushState
May 09 07:11:43 volumio volumio[800]: info: ------------------------------ 25ms
May 09 07:11:46 volumio volumio[800]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 13
May 09 07:11:46 volumio volumio[800]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 14
May 09 07:11:46 volumio volumio[800]: info: CoreCommandRouter::volumioGetState
May 09 07:11:46 volumio volumio[800]: info: CorePlayQueue::getTrack 1
May 09 07:11:46 volumio volumio[800]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%AD%90%E7%A5%A5/1a1ab959-a6e4-42cd-939d-5b800c46deba.jpg'
May 09 07:12:01 volumio volumio[800]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 09 07:12:01 volumio volumio[800]: Error: connect ETIMEDOUT 104.244.46.165:80
May 09 07:12:01 volumio volumio[800]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
May 09 07:12:01 volumio volumio[800]: errno: -110,
May 09 07:12:01 volumio volumio[800]: code: 'ETIMEDOUT',
May 09 07:12:01 volumio volumio[800]: syscall: 'connect',
May 09 07:12:01 volumio volumio[800]: address: '104.244.46.165',
May 09 07:12:01 volumio volumio[800]: port: 80
May 09 07:12:01 volumio volumio[800]: }
May 09 07:12:01 volumio volumio[800]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 09 07:12:01 volumio sudo[2321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-09 07:11
May 09 07:12:01 volumio sudo[2321]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET"
VOLUMIO_VERSION="3.634"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"