Apr 11 21:53:00 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 21:53:00 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 21:53:00 volumio volumio[8470]: info: Discovery: Getting this device information
Apr 11 21:53:00 volumio volumio[8470]: info: CoreCommandRouter::volumioGetState
Apr 11 21:53:00 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:00 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 21:53:00 volumio volumio[8470]: info: Discovery: adding a9f20d64-9f69-436a-bd84-4fa2949e2285
Apr 11 21:53:00 volumio volumio[8470]: info: Discovery: Found device Volumio
Apr 11 21:53:00 volumio volumio[8470]: info: CoreCommandRouter::volumioGetState
Apr 11 21:53:00 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:00 volumio sudo[9123]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 11 21:53:00 volumio sudo[9123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 21:53:00 volumio sudo[9125]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 11 21:53:00 volumio sudo[9123]: pam_unix(sudo:session): session closed for user root
Apr 11 21:53:00 volumio sudo[9125]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 21:53:00 volumio sudo[9125]: pam_unix(sudo:session): session closed for user root
Apr 11 21:53:00 volumio volumio[8470]: verbose: New Socket.io Connection to 192.168.3.177 from 192.168.3.167 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 10
Apr 11 21:53:00 volumio volumio5-onboarding[1820]: time=2026-04-11T21:53:00.822+08:00 level=INFO msg="service successfully established" component=discovery/localnet
Apr 11 21:53:00 volumio volumio[8470]: info: CoreCommandRouter::volumioGetState
Apr 11 21:53:00 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:00 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 11 21:53:00 volumio volumio[8470]: info: Listing playlists
Apr 11 21:53:00 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 11 21:53:00 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 11 21:53:00 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 11 21:53:00 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 11 21:53:01 volumio volumio[8470]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yanni/Sensuous%20Chill/e9bcef23-c50d-4dfe-b578-09c5affc5697.jpg'
Apr 11 21:53:01 volumio ntpd[1023]: IO: Listen normally on 5 wlan0 192.168.3.177:123
Apr 11 21:53:01 volumio ntpd[1023]: IO: new interface(s) found: waking up resolver
Apr 11 21:53:02 volumio volumio[8470]: info: CoreCommandRouter::volumioPlay
Apr 11 21:53:02 volumio volumio[8470]: info: CoreStateMachine::play index undefined
Apr 11 21:53:02 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:53:02 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:02 volumio volumio[8470]: info: CoreStateMachine::startPlaybackTimer
Apr 11 21:53:02 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:02 volumio volumio[8470]: verbose: ControllerMpd::clearAddPlayTracks USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac
Apr 11 21:53:02 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 21:53:02 volumio volumio[8470]: info: sendMpdCommand stop took 2 milliseconds
Apr 11 21:53:02 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 21:53:02 volumio volumio[8470]: info: sendMpdCommand clear took 1 milliseconds
Apr 11 21:53:02 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand add "USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac"
Apr 11 21:53:02 volumio volumio[8470]: info:
Apr 11 21:53:02 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:02 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:02 volumio volumio[8470]: info:
Apr 11 21:53:02 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:02 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:02 volumio volumio[8470]: info:
Apr 11 21:53:02 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:02 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:02 volumio volumio[8470]: info:
Apr 11 21:53:02 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:02 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:02 volumio volumio[8470]: info: sendMpdCommand add "USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac" took 8 milliseconds
Apr 11 21:53:02 volumio volumio[8470]: info: ------------------------------ 7ms
Apr 11 21:53:02 volumio volumio[8470]: info: ------------------------------ 5ms
Apr 11 21:53:02 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 21:53:02 volumio volumio[8470]: info:
Apr 11 21:53:02 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:02 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:02 volumio volumio[8470]: info:
Apr 11 21:53:02 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:02 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:02 volumio volumio[8470]: info: ------------------------------ 10ms
Apr 11 21:53:02 volumio volumio[8470]: info: ------------------------------ 10ms
Apr 11 21:53:02 volumio volumio[8470]: info: sendMpdCommand play took 6 milliseconds
Apr 11 21:53:02 volumio volumio[8470]: info: ------------------------------ 6ms
Apr 11 21:53:02 volumio volumio[8470]: info: ------------------------------ 4ms
Apr 11 21:53:02 volumio volumio[8470]: info:
Apr 11 21:53:02 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:02 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:02 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:02 volumio volumio[8470]: info:
Apr 11 21:53:02 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:02 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:02 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:02 volumio volumio[8470]: info:
Apr 11 21:53:02 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:02 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:02 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:02 volumio volumio[8470]: info: sendMpdCommand status took 10 milliseconds
Apr 11 21:53:02 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:02 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:02 volumio volumio[8470]: info:
Apr 11 21:53:02 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:02 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:02 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:03 volumio volumio[8470]: info: sendMpdCommand status took 15 milliseconds
Apr 11 21:53:03 volumio volumio[8470]: info: sendMpdCommand status took 14 milliseconds
Apr 11 21:53:03 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:03 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Thirst for Life","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac","trackType":"flac"}
Apr 11 21:53:03 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:53:03 volumio volumio[8470]: info: ------------------------------ 29ms
Apr 11 21:53:03 volumio volumio[8470]: info:
Apr 11 21:53:03 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:03 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:03 volumio volumio[8470]: info:
Apr 11 21:53:03 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:03 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:03 volumio volumio[8470]: info: sendMpdCommand status took 16 milliseconds
Apr 11 21:53:03 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 12 milliseconds
Apr 11 21:53:03 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 12 milliseconds
Apr 11 21:53:03 volumio volumio[8470]: info: sendMpdCommand status took 4 milliseconds
Apr 11 21:53:03 volumio volumio[8470]: info: sendMpdCommand status took 2 milliseconds
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:03 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Thirst for Life","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac","trackType":"flac"}
Apr 11 21:53:03 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:03 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:03 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4 Kbps","isStreaming":false,"title":"Thirst for Life","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac","trackType":"flac"}
Apr 11 21:53:03 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:03 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:03 volumio volumio[8470]: info: ------------------------------ 106ms
Apr 11 21:53:03 volumio volumio[8470]: info: ------------------------------ 105ms
Apr 11 21:53:03 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 75 milliseconds
Apr 11 21:53:03 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 75 milliseconds
Apr 11 21:53:03 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 75 milliseconds
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:03 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:03 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1246 Kbps","isStreaming":false,"title":"Thirst for Life","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac","trackType":"flac"}
Apr 11 21:53:03 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:03 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:03 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1246 Kbps","isStreaming":false,"title":"Thirst for Life","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac","trackType":"flac"}
Apr 11 21:53:03 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:03 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:03 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1246 Kbps","isStreaming":false,"title":"Thirst for Life","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac","trackType":"flac"}
Apr 11 21:53:03 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:03 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:03 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:03 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:03 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:03 volumio volumio[8470]: info: ------------------------------ 185ms
Apr 11 21:53:03 volumio volumio[8470]: info: ------------------------------ 172ms
Apr 11 21:53:03 volumio volumio[8470]: info: ------------------------------ 171ms
Apr 11 21:53:03 volumio kernel: perf: interrupt took too long (3967 > 3946), lowering kernel.perf_event_max_sample_rate to 50250
Apr 11 21:53:05 volumio volumio[8470]: info: Volumio Network Manager: Network status updated: 2
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::volumioSeek
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::seek
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: info: TRACKBLOCK {"uri":"mnt/USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac","service":"mpd","name":"Thirst for Life","artist":"Yanni","album":"Sensuous Chill","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=637&web=Yanni/Sensuous%20Chill/extralarge&path=%2FUSB%2F%E9%A3%9E%E4%B9%902025%2F%E9%9B%85%E5%B0%BC%EF%BC%9A%E5%86%B0%E7%81%AB%E6%81%8B%E6%AD%8C&metadata=false","duration":226,"trackType":"flac","samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2}
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::startPlaybackTimer
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: info: ControllerMpd::seek
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:07 volumio volumio[8470]: error: null
Apr 11 21:53:07 volumio volumio[8470]: info:
Apr 11 21:53:07 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:07 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:07 volumio volumio[8470]: info:
Apr 11 21:53:07 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:07 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:07 volumio volumio[8470]: info:
Apr 11 21:53:07 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:07 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:07 volumio volumio[8470]: info: sendMpdCommand status took 20 milliseconds
Apr 11 21:53:07 volumio volumio[8470]: info: sendMpdCommand status took 15 milliseconds
Apr 11 21:53:07 volumio volumio[8470]: info: sendMpdCommand status took 10 milliseconds
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:07 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 11 21:53:07 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 11 21:53:07 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:07 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:07 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":35855,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1410 Kbps","isStreaming":false,"title":"Thirst for Life","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac","trackType":"flac"}
Apr 11 21:53:07 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:07 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:07 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":35855,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1410 Kbps","isStreaming":false,"title":"Thirst for Life","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac","trackType":"flac"}
Apr 11 21:53:07 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:07 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:07 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":35855,"duration":226,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1410 Kbps","isStreaming":false,"title":"Thirst for Life","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac","trackType":"flac"}
Apr 11 21:53:07 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:07 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:07 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:07 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:07 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:07 volumio volumio[8470]: info: ------------------------------ 116ms
Apr 11 21:53:07 volumio volumio[8470]: info: ------------------------------ 111ms
Apr 11 21:53:07 volumio volumio[8470]: info: ------------------------------ 111ms
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::volumioNext
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::next
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::stop
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::stPlaybackTimer
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::updateTrackBlock
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrackBlock
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::serviceStop
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::serviceStop
Apr 11 21:53:08 volumio volumio[8470]: info: ControllerMpd::stop
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 21:53:08 volumio volumio[8470]: info:
Apr 11 21:53:08 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:08 volumio volumio[8470]: info: sendMpdCommand stop took 19 milliseconds
Apr 11 21:53:08 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::play index undefined
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::startPlaybackTimer
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::clearAddPlayTracks USB/飞乐2025/雅尼:冰火恋歌/11.Our Days.flac
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::updateTrackBlock
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrackBlock
Apr 11 21:53:08 volumio volumio[8470]: info: sendMpdCommand status took 5 milliseconds
Apr 11 21:53:08 volumio volumio[8470]: info: sendMpdCommand stop took 3 milliseconds
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 21:53:08 volumio volumio[8470]: info:
Apr 11 21:53:08 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:08 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:08 volumio volumio[8470]: info:
Apr 11 21:53:08 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:08 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:08 volumio volumio[8470]: info:
Apr 11 21:53:08 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:08 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:08 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 11 21:53:08 volumio volumio[8470]: info: sendMpdCommand clear took 6 milliseconds
Apr 11 21:53:08 volumio volumio[8470]: info: sendMpdCommand status took 4 milliseconds
Apr 11 21:53:08 volumio volumio[8470]: info: sendMpdCommand status took 3 milliseconds
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand add "USB/飞乐2025/雅尼:冰火恋歌/11.Our Days.flac"
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:08 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:08 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: 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":"Thirst for Life","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/01.Thirst for Life.flac","trackType":"flac"}
Apr 11 21:53:08 volumio volumio[8470]: verbose: CURRENT POSITION 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::syncState stateService stop
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:08 volumio volumio[8470]: info: No code
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:08 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: 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}
Apr 11 21:53:08 volumio volumio[8470]: verbose: CURRENT POSITION 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::syncState stateService stop
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:08 volumio volumio[8470]: info: No code
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:08 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: 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}
Apr 11 21:53:08 volumio volumio[8470]: verbose: CURRENT POSITION 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::syncState stateService stop
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:08 volumio volumio[8470]: info: No code
Apr 11 21:53:08 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:08 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:08 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 142ms
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 135ms
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 134ms
Apr 11 21:53:09 volumio volumio[8470]: info:
Apr 11 21:53:09 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:09 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:09 volumio volumio[8470]: info:
Apr 11 21:53:09 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:09 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:09 volumio volumio[8470]: error: updateQueue error: null
Apr 11 21:53:09 volumio volumio[8470]: info:
Apr 11 21:53:09 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:09 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 136ms
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand add "USB/飞乐2025/雅尼:冰火恋歌/11.Our Days.flac" took 134 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 3ms
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 3ms
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 21:53:09 volumio volumio[8470]: info:
Apr 11 21:53:09 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:09 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:09 volumio volumio[8470]: info:
Apr 11 21:53:09 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:09 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:09 volumio volumio[8470]: info:
Apr 11 21:53:09 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 89ms
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand play took 87 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 87ms
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 86ms
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:09 volumio volumio[8470]: info:
Apr 11 21:53:09 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:09 volumio volumio[8470]: info:
Apr 11 21:53:09 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:09 volumio volumio[8470]: info:
Apr 11 21:53:09 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand status took 12 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand status took 11 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand status took 11 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:09 volumio volumio[8470]: info:
Apr 11 21:53:09 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:09 volumio volumio[8470]: info:
Apr 11 21:53:09 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand status took 17 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 15 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 15 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand status took 10 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand status took 13 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":267,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1560 Kbps","isStreaming":false,"title":"Our Days","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/11.Our Days.flac","trackType":"flac"}
Apr 11 21:53:09 volumio volumio[8470]: verbose: CURRENT POSITION 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":267,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1560 Kbps","isStreaming":false,"title":"Our Days","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/11.Our Days.flac","trackType":"flac"}
Apr 11 21:53:09 volumio volumio[8470]: verbose: CURRENT POSITION 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:09 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":267,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1560 Kbps","isStreaming":false,"title":"Our Days","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/11.Our Days.flac","trackType":"flac"}
Apr 11 21:53:09 volumio volumio[8470]: verbose: CURRENT POSITION 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:09 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 59ms
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 92ms
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 92ms
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 68 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 65 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 65 milliseconds
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:09 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":267,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1560 Kbps","isStreaming":false,"title":"Our Days","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/11.Our Days.flac","trackType":"flac"}
Apr 11 21:53:09 volumio volumio[8470]: verbose: CURRENT POSITION 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:09 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":267,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1560 Kbps","isStreaming":false,"title":"Our Days","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/11.Our Days.flac","trackType":"flac"}
Apr 11 21:53:09 volumio volumio[8470]: verbose: CURRENT POSITION 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:09 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:09 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":267,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1560 Kbps","isStreaming":false,"title":"Our Days","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/11.Our Days.flac","trackType":"flac"}
Apr 11 21:53:09 volumio volumio[8470]: verbose: CURRENT POSITION 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:09 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 187ms
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 183ms
Apr 11 21:53:09 volumio volumio[8470]: info: ------------------------------ 183ms
Apr 11 21:53:09 volumio volumio[8470]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yanni/Sensuous%20Chill/e9bcef23-c50d-4dfe-b578-09c5affc5697.jpg'
Apr 11 21:53:09 volumio volumio[8470]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yanni/Sensuous%20Chill/e9bcef23-c50d-4dfe-b578-09c5affc5697.jpg'
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioRandom
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::writePlayerControls
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::setRandom false
Apr 11 21:53:09 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:09 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:09 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:11 volumio volumio[8470]: info: CoreCommandRouter::volumioRandom
Apr 11 21:53:11 volumio volumio[8470]: info: CoreCommandRouter::writePlayerControls
Apr 11 21:53:11 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:11 volumio volumio[8470]: info: CoreStateMachine::setRandom true
Apr 11 21:53:11 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:11 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:11 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:11 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:12 volumio volumio[8470]: info: CoreCommandRouter::volumioRandom
Apr 11 21:53:12 volumio volumio[8470]: info: CoreCommandRouter::writePlayerControls
Apr 11 21:53:12 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:12 volumio volumio[8470]: info: CoreStateMachine::setRandom false
Apr 11 21:53:12 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:12 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:12 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:12 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioNext
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::next
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::stop
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::stPlaybackTimer
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::updateTrackBlock
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrackBlock
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::serviceStop
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 10
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::serviceStop
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::stop
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand stop took 18 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::play index undefined
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::startPlaybackTimer
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::clearAddPlayTracks USB/飞乐2025/雅尼:冰火恋歌/12.A Little Too Late.flac
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::updateTrackBlock
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrackBlock
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand status took 8 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand stop took 10 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand status took 8 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand status took 7 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:14 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand clear took 5 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand add "USB/飞乐2025/雅尼:冰火恋歌/12.A Little Too Late.flac"
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: 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":"Our Days","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/11.Our Days.flac","trackType":"flac"}
Apr 11 21:53:14 volumio volumio[8470]: verbose: CURRENT POSITION 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState stateService stop
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: No code
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Apr 11 21:53:14 volumio volumio[8470]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 59ms
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 57ms
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 56ms
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:14 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:14 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:14 volumio volumio[8470]: error: updateQueue error: null
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:14 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 50ms
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand add "USB/飞乐2025/雅尼:冰火恋歌/12.A Little Too Late.flac" took 48 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 6ms
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 4ms
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:14 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:14 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 58ms
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand play took 44 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 44ms
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 44ms
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand status took 13 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand status took 12 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand status took 15 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:14 volumio volumio[8470]: info:
Apr 11 21:53:14 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand status took 31 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 29 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 29 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand status took 27 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 22 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand status took 21 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1569 Kbps","isStreaming":false,"title":"A Little Too Late","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/12.A Little Too Late.flac","trackType":"flac"}
Apr 11 21:53:14 volumio volumio[8470]: verbose: CURRENT POSITION 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1569 Kbps","isStreaming":false,"title":"A Little Too Late","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/12.A Little Too Late.flac","trackType":"flac"}
Apr 11 21:53:14 volumio volumio[8470]: verbose: CURRENT POSITION 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:14 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1569 Kbps","isStreaming":false,"title":"A Little Too Late","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/12.A Little Too Late.flac","trackType":"flac"}
Apr 11 21:53:14 volumio volumio[8470]: verbose: CURRENT POSITION 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:14 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 72ms
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 137ms
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 136ms
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 98 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 98 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 97 milliseconds
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:14 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1569 Kbps","isStreaming":false,"title":"A Little Too Late","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/12.A Little Too Late.flac","trackType":"flac"}
Apr 11 21:53:14 volumio volumio[8470]: verbose: CURRENT POSITION 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:14 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1569 Kbps","isStreaming":false,"title":"A Little Too Late","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/12.A Little Too Late.flac","trackType":"flac"}
Apr 11 21:53:14 volumio volumio[8470]: verbose: CURRENT POSITION 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:14 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1569 Kbps","isStreaming":false,"title":"A Little Too Late","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/12.A Little Too Late.flac","trackType":"flac"}
Apr 11 21:53:14 volumio volumio[8470]: verbose: CURRENT POSITION 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:14 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:14 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:14 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 243ms
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 239ms
Apr 11 21:53:14 volumio volumio[8470]: info: ------------------------------ 232ms
Apr 11 21:53:14 volumio volumio[8470]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yanni/Sensuous%20Chill/e9bcef23-c50d-4dfe-b578-09c5affc5697.jpg'
Apr 11 21:53:15 volumio volumio[8470]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 11 21:53:15 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 21:53:15 volumio volumio[8470]: info: CoreCommandRouter::volumioGetQueue
Apr 11 21:53:15 volumio volumio[8470]: info: CoreStateMachine::getQueue
Apr 11 21:53:15 volumio volumio[8470]: info: CorePlayQueue::getQueue
Apr 11 21:53:20 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 21:53:20 volumio volumio[8470]: info: CURURI: genres://
Apr 11 21:53:20 volumio volumio[8470]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Apr 11 21:53:20 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:53:23 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 21:53:23 volumio volumio[8470]: info: CURURI: genres://Folk
Apr 11 21:53:23 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:53:23 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:53:24 volumio wpa_supplicant[8236]: wlan0: WNM: Preferred List Available
Apr 11 21:53:24 volumio wpa_supplicant[8236]: wlan0: SME: Trying to authenticate with ac:bd:70:09:15:0c (SSID='GEB' freq=2462 MHz)
Apr 11 21:53:24 volumio dhcpcd[761]: wlan0: carrier lost
Apr 11 21:53:24 volumio kernel: wlan0: disconnect from AP ac:bd:70:09:15:10 for new auth to ac:bd:70:09:15:0c
Apr 11 21:53:24 volumio kernel: wlan0: authenticate with ac:bd:70:09:15:0c (local address=68:07:15:bd:7e:b4)
Apr 11 21:53:24 volumio kernel: wlan0: send auth to ac:bd:70:09:15:0c (try 1/3)
Apr 11 21:53:24 volumio avahi-daemon[8455]: Withdrawing address record for 192.168.3.177 on wlan0.
Apr 11 21:53:24 volumio avahi-daemon[8455]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.177.
Apr 11 21:53:24 volumio avahi-daemon[8455]: Interface wlan0.IPv4 no longer relevant for mDNS.
Apr 11 21:53:24 volumio dhcpcd[761]: wlan0: deleting route to 192.168.3.0/24
Apr 11 21:53:24 volumio volumio[8470]: info: Discovery: A device disappeared from network
Apr 11 21:53:24 volumio dhcpcd[761]: wlan0: deleting default route via 192.168.3.1
Apr 11 21:53:24 volumio dhcpcd[761]: wlan0: dhcp_envoption 213: Operation not supported
Apr 11 21:53:24 volumio kernel: wlan0: send auth to ac:bd:70:09:15:0c (try 2/3)
Apr 11 21:53:24 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0.
Apr 11 21:53:24 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0...
Apr 11 21:53:24 volumio systemd[1]: welcome.service: Deactivated successfully.
Apr 11 21:53:24 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Apr 11 21:53:24 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Apr 11 21:53:24 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Apr 11 21:53:24 volumio kernel: wlan0: send auth to ac:bd:70:09:15:0c (try 3/3)
Apr 11 21:53:24 volumio welcome[9273]: Resolved ip:[0]
Apr 11 21:53:24 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Apr 11 21:53:24 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0.
Apr 11 21:53:24 volumio kernel: wlan0: authentication with ac:bd:70:09:15:0c timed out
Apr 11 21:53:24 volumio wpa_supplicant[8236]: BSSID ac:bd:70:09:15:0c ignore list count incremented to 3, ignoring for 60 seconds
Apr 11 21:53:25 volumio volumio[8470]: info: Received Get System Info
Apr 11 21:53:25 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 21:53:25 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 21:53:25 volumio volumio[8470]: info: Discovery: Getting this device information
Apr 11 21:53:25 volumio volumio[8470]: info: CoreCommandRouter::volumioGetState
Apr 11 21:53:25 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:25 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 21:53:25 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 11 21:53:25 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 11 21:53:25 volumio volumio[8470]: info: Volumio Network Manager: Network status updated: 0
Apr 11 21:53:26 volumio volumio5-onboarding[1820]: time=2026-04-11T21:53:26.198+08:00 level=INFO msg="service successfully established" component=discovery/localnet
Apr 11 21:53:26 volumio ntpd[1023]: IO: Deleting interface #5 wlan0, 192.168.3.177#123, interface stats: received=8, sent=8, dropped=0, active_time=25 secs
Apr 11 21:53:26 volumio ntpd[1023]: PROTO: 120.236.184.252 unlink local addr 192.168.3.177 ->
Apr 11 21:53:26 volumio ntpd[1023]: PROTO: 193.182.111.142 unlink local addr 192.168.3.177 ->
Apr 11 21:53:26 volumio ntpd[1023]: PROTO: 119.28.206.193 unlink local addr 192.168.3.177 ->
Apr 11 21:53:26 volumio ntpd[1023]: PROTO: 202.118.1.81 unlink local addr 192.168.3.177 ->
Apr 11 21:53:26 volumio ntpd[1023]: PROTO: 84.16.73.33 unlink local addr 192.168.3.177 ->
Apr 11 21:53:26 volumio ntpd[1023]: PROTO: 162.159.200.1 unlink local addr 192.168.3.177 ->
Apr 11 21:53:26 volumio ntpd[1023]: PROTO: 139.199.214.202 unlink local addr 192.168.3.177 ->
Apr 11 21:53:26 volumio ntpd[1023]: PROTO: 193.182.111.143 unlink local addr 192.168.3.177 ->
Apr 11 21:53:26 volumio ntpd[1023]: PROTO: 193.182.111.141 unlink local addr 192.168.3.177 ->
Apr 11 21:53:26 volumio ntpd[1023]: PROTO: 185.209.85.222 unlink local addr 192.168.3.177 ->
Apr 11 21:53:26 volumio ntpd[1023]: PROTO: 162.159.200.123 unlink local addr 192.168.3.177 ->
Apr 11 21:53:26 volumio wpa_supplicant[8236]: wlan0: SME: Trying to authenticate with ac:bd:70:09:15:10 (SSID='GEB' freq=5745 MHz)
Apr 11 21:53:26 volumio wpa_supplicant[8236]: wlan0: Trying to associate with ac:bd:70:09:15:10 (SSID='GEB' freq=5745 MHz)
Apr 11 21:53:26 volumio kernel: wlan0: authenticate with ac:bd:70:09:15:10 (local address=68:07:15:bd:7e:b4)
Apr 11 21:53:26 volumio kernel: wlan0: send auth to ac:bd:70:09:15:10 (try 1/3)
Apr 11 21:53:26 volumio kernel: wlan0: authenticated
Apr 11 21:53:26 volumio kernel: wlan0: associate with ac:bd:70:09:15:10 (try 1/3)
Apr 11 21:53:26 volumio wpa_supplicant[8236]: wlan0: Associated with ac:bd:70:09:15:10
Apr 11 21:53:26 volumio kernel: wlan0: RX AssocResp from ac:bd:70:09:15:10 (capab=0x1531 status=0 aid=90)
Apr 11 21:53:26 volumio kernel: wlan0: associated
Apr 11 21:53:26 volumio wpa_supplicant[8236]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 11 21:53:26 volumio wpa_supplicant[8236]: wlan0: WPA: Key negotiation completed with ac:bd:70:09:15:10 [PTK=CCMP GTK=CCMP]
Apr 11 21:53:26 volumio wpa_supplicant[8236]: wlan0: CTRL-EVENT-CONNECTED - Connection to ac:bd:70:09:15:10 completed [id=0 id_str=]
Apr 11 21:53:26 volumio dhcpcd[761]: wlan0: carrier acquired
Apr 11 21:53:26 volumio dhcpcd[761]: wlan0: IAID 15:bd:7e:b4
Apr 11 21:53:26 volumio kernel: wlan0: Limiting TX power to 27 (27 - 0) dBm as advertised by ac:bd:70:09:15:10
Apr 11 21:53:26 volumio dhcpcd[761]: wlan0: rebinding lease of 192.168.3.177
Apr 11 21:53:26 volumio dhcpcd[761]: wlan0: probing address 192.168.3.177/24
Apr 11 21:53:26 volumio volumio[8470]: info: Received Get System Info
Apr 11 21:53:26 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 21:53:26 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 21:53:26 volumio volumio[8470]: info: Discovery: Getting this device information
Apr 11 21:53:26 volumio volumio[8470]: info: CoreCommandRouter::volumioGetState
Apr 11 21:53:26 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:26 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 21:53:26 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 11 21:53:26 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 11 21:53:27 volumio dhcpcd[761]: wlan0: soliciting an IPv6 router
Apr 11 21:53:27 volumio volumio5-onboarding[1820]: time=2026-04-11T21:53:27.856+08:00 level=INFO msg="service successfully established" component=discovery/localnet
Apr 11 21:53:31 volumio dhcpcd[761]: wlan0: leased 192.168.3.177 for 86400 seconds
Apr 11 21:53:31 volumio avahi-daemon[8455]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.177.
Apr 11 21:53:31 volumio avahi-daemon[8455]: New relevant interface wlan0.IPv4 for mDNS.
Apr 11 21:53:31 volumio avahi-daemon[8455]: Registering new address record for 192.168.3.177 on wlan0.IPv4.
Apr 11 21:53:31 volumio dhcpcd[761]: wlan0: adding route to 192.168.3.0/24
Apr 11 21:53:31 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0.
Apr 11 21:53:31 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0...
Apr 11 21:53:31 volumio systemd[1]: welcome.service: Deactivated successfully.
Apr 11 21:53:31 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Apr 11 21:53:31 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Apr 11 21:53:31 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Apr 11 21:53:31 volumio welcome[9322]: Resolved ip:[1] 192.168.3.177
Apr 11 21:53:31 volumio dhcpcd[761]: wlan0: adding default route via 192.168.3.1
Apr 11 21:53:31 volumio dhcpcd[761]: wlan0: dhcp_envoption 213: Operation not supported
Apr 11 21:53:31 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Apr 11 21:53:31 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0.
Apr 11 21:53:31 volumio volumio[8470]: info: Received Get System Info
Apr 11 21:53:31 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 21:53:31 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 21:53:31 volumio volumio[8470]: info: Discovery: Getting this device information
Apr 11 21:53:31 volumio volumio[8470]: info: CoreCommandRouter::volumioGetState
Apr 11 21:53:31 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:31 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 21:53:31 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 11 21:53:31 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 11 21:53:32 volumio volumio[8470]: info: Discovery: adding a9f20d64-9f69-436a-bd84-4fa2949e2285
Apr 11 21:53:32 volumio volumio[8470]: info: Discovery: Found device Volumio
Apr 11 21:53:32 volumio volumio[8470]: info: CoreCommandRouter::volumioGetState
Apr 11 21:53:32 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:32 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 21:53:32 volumio volumio[8470]: info: CURURI: genres://Folk/%3F%3F%3F%20/%3F%3F%3F%3FHQCD%20
Apr 11 21:53:32 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 21:53:32 volumio volumio[8470]: info: CURURI: genres://Folk/%3F%3F%3F%20/%3F%3F%3F%3FHQCD%20
Apr 11 21:53:32 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:53:32 volumio volumio[8470]: info: Preloading song: music-library/USB/飞乐2025/宋祖英《百年留声HQCD》/宋祖英《百年留声HQCD》.wav
Apr 11 21:53:32 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:53:32 volumio volumio[8470]: info: Preloading song: music-library/USB/飞乐2025/宋祖英《百年留声HQCD》/宋祖英《百年留声HQCD》.wav
Apr 11 21:53:32 volumio volumio5-onboarding[1820]: time=2026-04-11T21:53:32.811+08:00 level=INFO msg="service successfully established" component=discovery/localnet
Apr 11 21:53:32 volumio volumio[8470]: info: Exploding uri music-library/USB/飞乐2025/宋祖英《百年留声HQCD》/宋祖英《百年留声HQCD》.wav in service mpd
Apr 11 21:53:32 volumio volumio[8470]: info: ALBUMART /albumart?cacheid=637&web=%3F%3F%3F%20/%3F%3F%3F%3FHQCD%20/extralarge&path=%2Fmnt%2FUSB%2F%E9%A3%9E%E4%B9%902025%2F%E5%AE%8B%E7%A5%96%E8%8B%B1%E3%80%8A%E7%99%BE%E5%B9%B4%E7%95%99%E5%A3%B0HQCD%E3%80%8B%2F%E5%AE%8B%E7%A5%96%E8%8B%B1%E3%80%8A%E7%99%BE%E5%B9%B4%E7%95%99%E5%A3%B0HQCD%E3%80%8B.wav&metadata=false
Apr 11 21:53:32 volumio volumio[8470]: info: URI /mnt/USB/飞乐2025/宋祖英《百年留声HQCD》/宋祖英《百年留声HQCD》.wav
Apr 11 21:53:33 volumio ntpd[1023]: IO: Listen normally on 6 wlan0 192.168.3.177:123
Apr 11 21:53:33 volumio ntpd[1023]: IO: new interface(s) found: waking up resolver
Apr 11 21:53:35 volumio volumio[8470]: info: Volumio Network Manager: Network status updated: 2
Apr 11 21:53:41 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 21:53:41 volumio volumio[8470]: info: CURURI: genres://%E7%A6%85%E4%B9%90
Apr 11 21:53:41 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:53:41 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:53:43 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 21:53:43 volumio volumio[8470]: info: CURURI: genres://%E7%A6%85%E4%B9%90/%E7%A9%BA%E9%9B%A8%E4%BD%9C%E5%93%81/%E7%A9%BA%E9%9B%A8%E7%A6%85%E9%9F%B3
Apr 11 21:53:43 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:53:43 volumio volumio[8470]: info: Preloading song: music-library/USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac
Apr 11 21:53:43 volumio volumio[8470]: info: Preloading song: music-library/USB/飞乐2025/空雨作品 古琴单曲集/香钟.flac
Apr 11 21:53:43 volumio volumio[8470]: info: Preloading song: music-library/USB/飞乐2025/空雨作品 古琴单曲集/心湖.flac
Apr 11 21:53:43 volumio volumio[8470]: info: Exploding uri music-library/USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac in service mpd
Apr 11 21:53:43 volumio volumio[8470]: info: ALBUMART /albumart?cacheid=637&web=%E7%A9%BA%E9%9B%A8/%E7%A9%BA%E9%9B%A8%E7%A6%85%E9%9F%B3/extralarge&path=%2Fmnt%2FUSB%2F%E9%A3%9E%E4%B9%902025%2F%E7%A9%BA%E9%9B%A8%E4%BD%9C%E5%93%81%20%E5%8F%A4%E7%90%B4%E5%8D%95%E6%9B%B2%E9%9B%86%2F%E7%A9%BA%E5%AF%82%E5%B1%B1%E8%B0%B7.flac&metadata=false
Apr 11 21:53:43 volumio volumio[8470]: info: URI /mnt/USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac
Apr 11 21:53:43 volumio volumio[8470]: info: Exploding uri music-library/USB/飞乐2025/空雨作品 古琴单曲集/香钟.flac in service mpd
Apr 11 21:53:43 volumio volumio[8470]: info: ALBUMART /albumart?cacheid=637&web=%E7%A9%BA%E9%9B%A8/%E7%A9%BA%E9%9B%A8%E7%A6%85%E9%9F%B3/extralarge&path=%2Fmnt%2FUSB%2F%E9%A3%9E%E4%B9%902025%2F%E7%A9%BA%E9%9B%A8%E4%BD%9C%E5%93%81%20%E5%8F%A4%E7%90%B4%E5%8D%95%E6%9B%B2%E9%9B%86%2F%E9%A6%99%E9%92%9F.flac&metadata=false
Apr 11 21:53:43 volumio volumio[8470]: info: URI /mnt/USB/飞乐2025/空雨作品 古琴单曲集/香钟.flac
Apr 11 21:53:43 volumio volumio[8470]: info: Exploding uri music-library/USB/飞乐2025/空雨作品 古琴单曲集/心湖.flac in service mpd
Apr 11 21:53:43 volumio volumio[8470]: info: ALBUMART /albumart?cacheid=637&web=%E7%A9%BA%E9%9B%A8/%E7%A9%BA%E9%9B%A8%E7%A6%85%E9%9F%B3/extralarge&path=%2Fmnt%2FUSB%2F%E9%A3%9E%E4%B9%902025%2F%E7%A9%BA%E9%9B%A8%E4%BD%9C%E5%93%81%20%E5%8F%A4%E7%90%B4%E5%8D%95%E6%9B%B2%E9%9B%86%2F%E5%BF%83%E6%B9%96.flac&metadata=false
Apr 11 21:53:43 volumio volumio[8470]: info: URI /mnt/USB/飞乐2025/空雨作品 古琴单曲集/心湖.flac
Apr 11 21:53:44 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::ClearQueue
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::stop
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::stPlaybackTimer
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::updateTrackBlock
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrackBlock
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::serviceStop
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 11
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::serviceStop
Apr 11 21:53:44 volumio volumio[8470]: info: ControllerMpd::stop
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::clearPlayQueue
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::saveQueue
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushQueue
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::addQueueItems
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::addQueueItems
Apr 11 21:53:44 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:53:44 volumio volumio[8470]: info: Adding Item to queue: genres://%E7%A6%85%E4%B9%90/%E7%A9%BA%E9%9B%A8%E4%BD%9C%E5%93%81/%E7%A9%BA%E9%9B%A8%E7%A6%85%E9%9F%B3
Apr 11 21:53:44 volumio volumio[8470]: info: Exploding uri genres://%E7%A6%85%E4%B9%90/%E7%A9%BA%E9%9B%A8%E4%BD%9C%E5%93%81/%E7%A9%BA%E9%9B%A8%E7%A6%85%E9%9F%B3 in service mpd
Apr 11 21:53:44 volumio volumio[8470]: info:
Apr 11 21:53:44 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:44 volumio volumio[8470]: info: sendMpdCommand stop took 45 milliseconds
Apr 11 21:53:44 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushQueue
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::saveQueue
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::updateTrackBlock
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrackBlock
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPlay
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::play index 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::stop
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::play index undefined
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::startPlaybackTimer
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::clearAddPlayTracks USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 21:53:44 volumio volumio[8470]: info: sendMpdCommand status took 29 milliseconds
Apr 11 21:53:44 volumio volumio[8470]: info: sendMpdCommand stop took 10 milliseconds
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 21:53:44 volumio volumio[8470]: info:
Apr 11 21:53:44 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:44 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:44 volumio volumio[8470]: info:
Apr 11 21:53:44 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:44 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:44 volumio volumio[8470]: info:
Apr 11 21:53:44 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:44 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:44 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 11 21:53:44 volumio volumio[8470]: info: sendMpdCommand clear took 10 milliseconds
Apr 11 21:53:44 volumio volumio[8470]: info: sendMpdCommand status took 5 milliseconds
Apr 11 21:53:44 volumio volumio[8470]: info: sendMpdCommand status took 3 milliseconds
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand add "USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac"
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:44 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: 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":"A Little Too Late","artist":"Yanni","album":"Sensuous Chill","uri":"USB/飞乐2025/雅尼:冰火恋歌/12.A Little Too Late.flac","trackType":"flac"}
Apr 11 21:53:44 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::syncState stateService stop
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:44 volumio volumio[8470]: info: No code
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:44 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: 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}
Apr 11 21:53:44 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::syncState stateService stop
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:44 volumio volumio[8470]: info: No code
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:44 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: 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}
Apr 11 21:53:44 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::syncState stateService stop
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:44 volumio volumio[8470]: info: No code
Apr 11 21:53:44 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:44 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:44 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:44 volumio volumio[8470]: info: ------------------------------ 167ms
Apr 11 21:53:44 volumio volumio[8470]: info: ------------------------------ 134ms
Apr 11 21:53:44 volumio volumio[8470]: info: ------------------------------ 128ms
Apr 11 21:53:44 volumio volumio[8470]: info:
Apr 11 21:53:44 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:44 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:44 volumio volumio[8470]: info:
Apr 11 21:53:44 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:44 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:44 volumio volumio[8470]: error: updateQueue error: null
Apr 11 21:53:44 volumio volumio[8470]: info:
Apr 11 21:53:44 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:44 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:44 volumio volumio[8470]: info: ------------------------------ 145ms
Apr 11 21:53:44 volumio volumio[8470]: info: sendMpdCommand add "USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac" took 144 milliseconds
Apr 11 21:53:44 volumio volumio[8470]: info: ------------------------------ 18ms
Apr 11 21:53:44 volumio volumio[8470]: info: ------------------------------ 17ms
Apr 11 21:53:44 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 21:53:45 volumio volumio[8470]: info:
Apr 11 21:53:45 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:45 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:45 volumio volumio[8470]: info:
Apr 11 21:53:45 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:53:45 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:53:45 volumio volumio[8470]: info:
Apr 11 21:53:45 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:45 volumio volumio[8470]: info: ------------------------------ 112ms
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand play took 112 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: info: ------------------------------ 98ms
Apr 11 21:53:45 volumio volumio[8470]: info: ------------------------------ 97ms
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:45 volumio volumio[8470]: info:
Apr 11 21:53:45 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:45 volumio volumio[8470]: info:
Apr 11 21:53:45 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:45 volumio volumio[8470]: info:
Apr 11 21:53:45 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand status took 40 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand status took 39 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand status took 39 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:45 volumio volumio[8470]: info:
Apr 11 21:53:45 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:45 volumio volumio[8470]: info:
Apr 11 21:53:45 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand status took 32 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 25 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 28 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 29 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand status took 24 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand status took 23 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"585 Kbps","isStreaming":false,"title":"空寂山谷","artist":"空雨","album":"空雨禅音","uri":"USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac","trackType":"flac"}
Apr 11 21:53:45 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"585 Kbps","isStreaming":false,"title":"空寂山谷","artist":"空雨","album":"空雨禅音","uri":"USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac","trackType":"flac"}
Apr 11 21:53:45 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:45 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"585 Kbps","isStreaming":false,"title":"空寂山谷","artist":"空雨","album":"空雨禅音","uri":"USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac","trackType":"flac"}
Apr 11 21:53:45 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:45 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:45 volumio volumio[8470]: info: ------------------------------ 121ms
Apr 11 21:53:45 volumio volumio[8470]: info: ------------------------------ 215ms
Apr 11 21:53:45 volumio volumio[8470]: info: ------------------------------ 218ms
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 149 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 148 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 149 milliseconds
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:45 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"585 Kbps","isStreaming":false,"title":"空寂山谷","artist":"空雨","album":"空雨禅音","uri":"USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac","trackType":"flac"}
Apr 11 21:53:45 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:45 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1094,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"581 Kbps","isStreaming":false,"title":"空寂山谷","artist":"空雨","album":"空雨禅音","uri":"USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac","trackType":"flac"}
Apr 11 21:53:45 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:45 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:45 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1094,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"581 Kbps","isStreaming":false,"title":"空寂山谷","artist":"空雨","album":"空雨禅音","uri":"USB/飞乐2025/空雨作品 古琴单曲集/空寂山谷.flac","trackType":"flac"}
Apr 11 21:53:45 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:53:45 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:45 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:53:45 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:53:45 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:53:45 volumio volumio[8470]: info: ------------------------------ 295ms
Apr 11 21:53:45 volumio volumio[8470]: info: ------------------------------ 280ms
Apr 11 21:53:45 volumio volumio[8470]: info: ------------------------------ 280ms
Apr 11 21:54:08 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 21:54:08 volumio volumio[8470]: info: CURURI: albums://
Apr 11 21:54:08 volumio volumio[8470]: info: listAlbums - loading Albums from cache
Apr 11 21:54:09 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:54:17 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:54:17 volumio volumio[8470]: info: Preloading song: mnt/USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac
Apr 11 21:54:17 volumio volumio[8470]: info: Exploding uri mnt/USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac in service mpd
Apr 11 21:54:17 volumio volumio[8470]: info: ALBUMART /albumart?cacheid=637&web=%E4%B8%B9%E6%AD%A3%E6%AF%8D%E5%AD%90/%E4%B9%8C%E5%85%B0%E5%B7%B4%E6%89%98%E7%9A%84%E5%A4%9C(%E5%A3%B0%E4%B9%90%E5%90%88%E9%9B%86)/extralarge&path=%2Fmnt%2FUSB%2F%E9%A3%9E%E4%B9%902025%2F%E4%B9%8C%E5%85%B0%E5%B7%B4%E6%89%98%E7%9A%84%E5%A4%9C%20(%E4%B8%8D%E5%90%8C%E6%AD%8C%E6%89%8B%E6%BC%94%E7%BB%8E%E7%89%88%E6%9C%AC%E5%90%88%E9%9B%86)%2F%E4%B8%B9%E6%AD%A3%E6%AF%8D%E5%AD%90%20-%20%E4%B9%8C%E5%85%B0%E5%B7%B4%E6%89%98%E7%9A%84%E5%A4%9C%20(%E4%B8%B9%E6%AD%A3%E6%AF%8D%E5%AD%90%E7%89%88).flac&metadata=false
Apr 11 21:54:17 volumio volumio[8470]: info: URI /mnt/USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac
Apr 11 21:54:18 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::ClearQueue
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::stop
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::stPlaybackTimer
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::updateTrackBlock
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrackBlock
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::serviceStop
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::serviceStop
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::stop
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::clearPlayQueue
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::saveQueue
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushQueue
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::addQueueItems
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::addQueueItems
Apr 11 21:54:18 volumio volumio[8470]: info: Preload queue cleared
Apr 11 21:54:18 volumio volumio[8470]: info: Adding Item to queue: mnt/USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac
Apr 11 21:54:18 volumio volumio[8470]: info: Using cached record of: mnt/USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushQueue
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::saveQueue
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::updateTrackBlock
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrackBlock
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPlay
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::play index 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::stop
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::play index undefined
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::startPlaybackTimer
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::clearAddPlayTracks USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand stop took 60 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand stop took 20 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:54:18 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand status took 8 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand clear took 5 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand status took 4 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand status took 3 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand add "USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac"
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: 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}
Apr 11 21:54:18 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState stateService stop
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: No code
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: 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}
Apr 11 21:54:18 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState stateService stop
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: No code
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 114ms
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 114ms
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:54:18 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:54:18 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:54:18 volumio volumio[8470]: error: updateQueue error: null
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:54:18 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 117ms
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 115 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand add "USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac" took 116 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 5ms
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 4ms
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 21:54:18 volumio volumio[8470]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 127ms
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:54:18 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces system playlist update
Apr 11 21:54:18 volumio volumio[8470]: info: Ignoring MPD Status Update
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 35ms
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand play took 32 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 31ms
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 32ms
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand status took 23 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand status took 23 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand status took 6 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:54:18 volumio volumio[8470]: info:
Apr 11 21:54:18 volumio volumio[8470]: ---------------------------- MPD announces state update: player
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::getState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand status took 19 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 19 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 19 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 10 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand status took 9 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand status took 8 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseState
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"乌兰巴托的夜(丹正母子版)","artist":"丹正母子","album":"乌兰巴托的夜(声乐合集)","uri":"USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac","trackType":"flac"}
Apr 11 21:54:18 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10,"duration":191,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"乌兰巴托的夜(丹正母子版)","artist":"丹正母子","album":"乌兰巴托的夜(声乐合集)","uri":"USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac","trackType":"flac"}
Apr 11 21:54:18 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:54:18 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":191,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"773 Kbps","isStreaming":false,"title":"乌兰巴托的夜(丹正母子版)","artist":"丹正母子","album":"乌兰巴托的夜(声乐合集)","uri":"USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac","trackType":"flac"}
Apr 11 21:54:18 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:54:18 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 84ms
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 147ms
Apr 11 21:54:18 volumio volumio[8470]: info: ------------------------------ 146ms
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 115 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 114 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: info: sendMpdCommand playlistinfo took 114 milliseconds
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:54:18 volumio volumio[8470]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":191,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"773 Kbps","isStreaming":false,"title":"乌兰巴托的夜(丹正母子版)","artist":"丹正母子","album":"乌兰巴托的夜(声乐合集)","uri":"USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac","trackType":"flac"}
Apr 11 21:54:18 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:54:18 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":191,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"773 Kbps","isStreaming":false,"title":"乌兰巴托的夜(丹正母子版)","artist":"丹正母子","album":"乌兰巴托的夜(声乐合集)","uri":"USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac","trackType":"flac"}
Apr 11 21:54:18 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:54:18 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: ControllerMpd::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::servicePushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":191,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"773 Kbps","isStreaming":false,"title":"乌兰巴托的夜(丹正母子版)","artist":"丹正母子","album":"乌兰巴托的夜(声乐合集)","uri":"USB/飞乐2025/乌兰巴托的夜 (不同歌手演绎版本合集)/丹正母子 - 乌兰巴托的夜 (丹正母子版).flac","trackType":"flac"}
Apr 11 21:54:18 volumio volumio[8470]: verbose: CURRENT POSITION 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState stateService play
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::syncState currentStatus play
Apr 11 21:54:18 volumio volumio[8470]: info: Received an update from plugin. extracting info from payload
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:18 volumio volumio[8470]: info: CoreStateMachine::pushState
Apr 11 21:54:18 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:18 volumio volumio[8470]: info: CoreCommandRouter::volumioPushState
Apr 11 21:54:19 volumio volumio[8470]: info: ------------------------------ 242ms
Apr 11 21:54:19 volumio volumio[8470]: info: ------------------------------ 230ms
Apr 11 21:54:19 volumio volumio[8470]: info: ------------------------------ 230ms
Apr 11 21:54:34 volumio sudo[9648]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 11 21:54:34 volumio sudo[9648]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 21:54:34 volumio sudo[9650]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 11 21:54:34 volumio sudo[9648]: pam_unix(sudo:session): session closed for user root
Apr 11 21:54:34 volumio sudo[9650]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 21:54:34 volumio sudo[9650]: pam_unix(sudo:session): session closed for user root
Apr 11 21:54:34 volumio volumio[8470]: verbose: New Socket.io Connection to 192.168.3.177 from 192.168.3.167 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 9
Apr 11 21:54:34 volumio volumio[8470]: info: CoreCommandRouter::volumioGetState
Apr 11 21:54:34 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:34 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 11 21:54:34 volumio volumio[8470]: info: Listing playlists
Apr 11 21:54:34 volumio volumio[8470]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 11 21:54:34 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 21:54:34 volumio volumio[8470]: info: CoreCommandRouter::volumioGetQueue
Apr 11 21:54:34 volumio volumio[8470]: info: CoreStateMachine::getQueue
Apr 11 21:54:34 volumio volumio[8470]: info: CorePlayQueue::getQueue
Apr 11 21:54:35 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 11 21:54:35 volumio volumio[8470]: info: Received Get System Info
Apr 11 21:54:35 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 21:54:35 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 21:54:35 volumio volumio[8470]: info: Discovery: Getting this device information
Apr 11 21:54:35 volumio volumio[8470]: info: CoreCommandRouter::volumioGetState
Apr 11 21:54:35 volumio volumio[8470]: info: CorePlayQueue::getTrack 0
Apr 11 21:54:35 volumio volumio[8470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 21:54:35 volumio volumio[8470]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 21:54:35 volumio volumio[8470]: Error: connect ENETUNREACH 211.104.160.39:443
Apr 11 21:54:35 volumio volumio[8470]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Apr 11 21:54:35 volumio volumio[8470]: errno: -101,
Apr 11 21:54:35 volumio volumio[8470]: code: 'ENETUNREACH',
Apr 11 21:54:35 volumio volumio[8470]: syscall: 'connect',
Apr 11 21:54:35 volumio volumio[8470]: address: '211.104.160.39',
Apr 11 21:54:35 volumio volumio[8470]: port: 443
Apr 11 21:54:35 volumio volumio[8470]: }
Apr 11 21:54:35 volumio volumio[8470]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 21:54:35 volumio sudo[9686]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-11 21:53'
Apr 11 21:54:35 volumio sudo[9686]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"