-- Logs begin at Wed 2025-10-29 04:42:08 UTC, end at Thu 2025-10-30 06:01:53 UTC. --
Oct 30 06:00:00 volumio volumio[4024]: info:
Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:00 volumio volumio[4024]: info:
Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:00 volumio volumio[4024]: info:
Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:00 volumio volumio[4024]: info:
Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:00 volumio volumio[4024]: info:
Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:00 volumio volumio[4024]: info:
Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:01 volumio volumio[4024]: info:
Oct 30 06:00:01 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:01 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:01 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:01 volumio volumio[4024]: info: sendMpdCommand status took 6 milliseconds
Oct 30 06:00:01 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:01 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:01 volumio volumio[4024]: info:
Oct 30 06:00:01 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:01 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:01 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:01 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds
Oct 30 06:00:01 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:01 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:01 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:01 volumio volumio[4024]: In UPNP mode
Oct 30 06:00:01 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:50425/bridge-92.flac","trackType":"flac"}
Oct 30 06:00:01 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:01 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play
Oct 30 06:00:01 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus stop
Oct 30 06:00:01 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:01 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:02 volumio volumio[4024]: info: ------------------------------ 10ms
Oct 30 06:00:02 volumio volumio[4024]: info: sendMpdCommand status took 5 milliseconds
Oct 30 06:00:02 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:02 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:02 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 30 06:00:02 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:02 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:02 volumio volumio[4024]: In UPNP mode
Oct 30 06:00:02 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":319,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1909 Kbps","isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:50425/bridge-92.flac","trackType":"flac"}
Oct 30 06:00:02 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play
Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play
Oct 30 06:00:02 volumio volumio[4024]: info: Received an update from plugin. extracting info from payload
Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:02 volumio volumio[4024]: info: ------------------------------ 9ms
Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:02 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:02 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:02 volumio volumio[4024]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%99%E9%9C%B2/%E5%8F%A6%E4%B8%80%E7%A7%8D%E6%83%85%E6%84%9F/d0292c45-0ac5-460a-8120-630a110febf6.jpg'
Oct 30 06:00:05 volumio volumio[4024]: info:
Oct 30 06:00:05 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:05 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:05 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:05 volumio volumio[4024]: info: sendMpdCommand status took 0 milliseconds
Oct 30 06:00:05 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:05 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:05 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds
Oct 30 06:00:05 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:05 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:05 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:05 volumio volumio[4024]: In UPNP mode
Oct 30 06:00:05 volumio volumio[4024]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2734,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1913 Kbps","isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:50425/bridge-92.flac","trackType":"flac"}
Oct 30 06:00:05 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:05 volumio volumio[4024]: info: CoreStateMachine::syncState stateService pause
Oct 30 06:00:05 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play
Oct 30 06:00:05 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:05 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:05 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:05 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer
Oct 30 06:00:05 volumio volumio[4024]: info: ------------------------------ 3ms
Oct 30 06:00:05 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:05 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:05 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:15 volumio volumio[4024]: info:
Oct 30 06:00:15 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:15 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:15 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:15 volumio volumio[4024]: info: sendMpdCommand status took 1 milliseconds
Oct 30 06:00:15 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:15 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:15 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 30 06:00:15 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:15 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:15 volumio volumio[4024]: info: CorePlayQueue::getTrack 0
Oct 30 06:00:15 volumio volumio[4024]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:50425/bridge-92.flac","trackType":"flac"}
Oct 30 06:00:15 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::syncState stateService stop
Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play
Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer
Oct 30 06:00:15 volumio volumio[4024]: info: ------------------------------ 7ms
Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:15 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:15 volumio volumio[4024]: info: Clearing queue after UPNP request
Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::ClearQueue
Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::stop
Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 30 06:00:15 volumio volumio[4024]: UNSET VOLATILE
Oct 30 06:00:15 volumio volumio[4024]: info: CorePlayQueue::clearPlayQueue
Oct 30 06:00:15 volumio volumio[4024]: info: CorePlayQueue::saveQueue
Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioPushQueue
Oct 30 06:00:15 volumio volumio[4024]: info:
Oct 30 06:00:15 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:15 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:15 volumio volumio[4024]: error: updateQueue error: null
Oct 30 06:00:15 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:15 volumio volumio[4024]: info: Starting UPNP Playback
Oct 30 06:00:15 volumio volumio[4024]: info: Preparing playback through UPNP
Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioGetState
Oct 30 06:00:15 volumio volumio[4024]: info: CorePlayQueue::getTrack 0
Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 30 06:00:16 volumio volumio[4024]: info:
Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:16 volumio volumio[4024]: info:
Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:16 volumio volumio[4024]: info:
Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:16 volumio volumio[4024]: info:
Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:16 volumio volumio[4024]: info:
Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:16 volumio volumio[4024]: info:
Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:17 volumio volumio[4024]: info:
Oct 30 06:00:17 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:17 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:17 volumio volumio[4024]: info: sendMpdCommand status took 9 milliseconds
Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:17 volumio volumio[4024]: info:
Oct 30 06:00:17 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:17 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:17 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds
Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:17 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:17 volumio volumio[4024]: In UPNP mode
Oct 30 06:00:17 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:55587/bridge-93.flac","trackType":"flac"}
Oct 30 06:00:17 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play
Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus stop
Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:17 volumio volumio[4024]: info: ------------------------------ 13ms
Oct 30 06:00:17 volumio volumio[4024]: info: sendMpdCommand status took 3 milliseconds
Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:17 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:17 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:17 volumio volumio[4024]: In UPNP mode
Oct 30 06:00:17 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":365,"duration":230,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1914 Kbps","isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:55587/bridge-93.flac","trackType":"flac"}
Oct 30 06:00:17 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play
Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play
Oct 30 06:00:17 volumio volumio[4024]: info: Received an update from plugin. extracting info from payload
Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:17 volumio volumio[4024]: info: ------------------------------ 8ms
Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:17 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:17 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:20 volumio volumio[4024]: info:
Oct 30 06:00:20 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:20 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:20 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:20 volumio volumio[4024]: info: sendMpdCommand status took 1 milliseconds
Oct 30 06:00:20 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:20 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:20 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds
Oct 30 06:00:20 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:20 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:20 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:20 volumio volumio[4024]: In UPNP mode
Oct 30 06:00:20 volumio volumio[4024]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2269,"duration":230,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2846 Kbps","isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:55587/bridge-93.flac","trackType":"flac"}
Oct 30 06:00:20 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:20 volumio volumio[4024]: info: CoreStateMachine::syncState stateService pause
Oct 30 06:00:20 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play
Oct 30 06:00:20 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:20 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:20 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:20 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer
Oct 30 06:00:20 volumio volumio[4024]: info: ------------------------------ 5ms
Oct 30 06:00:20 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:20 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:20 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:24 volumio volumio[4024]: info:
Oct 30 06:00:24 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:24 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:24 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:24 volumio volumio[4024]: info: sendMpdCommand status took 0 milliseconds
Oct 30 06:00:24 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:24 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:24 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 30 06:00:24 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:24 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:24 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:24 volumio volumio[4024]: info: CorePlayQueue::getTrack 0
Oct 30 06:00:24 volumio volumio[4024]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:55587/bridge-93.flac","trackType":"flac"}
Oct 30 06:00:24 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:24 volumio volumio[4024]: info: CoreStateMachine::syncState stateService stop
Oct 30 06:00:24 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play
Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:24 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer
Oct 30 06:00:24 volumio volumio[4024]: info: ------------------------------ 6ms
Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:24 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:24 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:25 volumio volumio[4024]: info: Clearing queue after UPNP request
Oct 30 06:00:25 volumio volumio[4024]: info: CoreStateMachine::ClearQueue
Oct 30 06:00:25 volumio volumio[4024]: info: CoreStateMachine::stop
Oct 30 06:00:25 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 30 06:00:25 volumio volumio[4024]: UNSET VOLATILE
Oct 30 06:00:25 volumio volumio[4024]: info: CorePlayQueue::clearPlayQueue
Oct 30 06:00:25 volumio volumio[4024]: info: CorePlayQueue::saveQueue
Oct 30 06:00:25 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:25 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:25 volumio volumio[4024]: info: CoreCommandRouter::volumioPushQueue
Oct 30 06:00:25 volumio volumio[4024]: info:
Oct 30 06:00:25 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:25 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:25 volumio volumio[4024]: error: updateQueue error: null
Oct 30 06:00:25 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:25 volumio volumio[4024]: info: Starting UPNP Playback
Oct 30 06:00:25 volumio volumio[4024]: info: Preparing playback through UPNP
Oct 30 06:00:25 volumio volumio[4024]: info: CoreCommandRouter::volumioGetState
Oct 30 06:00:25 volumio volumio[4024]: info: CorePlayQueue::getTrack 0
Oct 30 06:00:25 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 30 06:00:26 volumio volumio[4024]: info:
Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:26 volumio volumio[4024]: info:
Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:26 volumio volumio[4024]: info:
Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:26 volumio volumio[4024]: info:
Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:26 volumio volumio[4024]: info:
Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 2ms
Oct 30 06:00:26 volumio volumio[4024]: info:
Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:33 volumio volumio[4024]: info:
Oct 30 06:00:33 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:33 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:33 volumio volumio[4024]: info:
Oct 30 06:00:33 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:33 volumio volumio[4024]: info: sendMpdCommand status took 10 milliseconds
Oct 30 06:00:33 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:33 volumio volumio[4024]: info: sendMpdCommand status took 0 milliseconds
Oct 30 06:00:33 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:33 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:33 volumio volumio[4024]: In UPNP mode
Oct 30 06:00:33 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":287,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1025 Kbps","isStreaming":false,"title":"驼铃","artist":"刘紫玲","album":"如歌岁月[Remaster]","uri":"http://192.168.1.17:39829/bridge-94.flac","trackType":"flac"}
Oct 30 06:00:33 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play
Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus stop
Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:33 volumio volumio[4024]: info: ------------------------------ 13ms
Oct 30 06:00:33 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:33 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:33 volumio volumio[4024]: In UPNP mode
Oct 30 06:00:33 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":458,"duration":287,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1032 Kbps","isStreaming":false,"title":"驼铃","artist":"刘紫玲","album":"如歌岁月[Remaster]","uri":"http://192.168.1.17:39829/bridge-94.flac","trackType":"flac"}
Oct 30 06:00:33 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play
Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play
Oct 30 06:00:33 volumio volumio[4024]: info: Received an update from plugin. extracting info from payload
Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:33 volumio volumio[4024]: info: ------------------------------ 8ms
Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:33 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:33 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:34 volumio volumio[4024]: info:
Oct 30 06:00:34 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:34 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:34 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:34 volumio volumio[4024]: info: sendMpdCommand status took 0 milliseconds
Oct 30 06:00:34 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:34 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:34 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds
Oct 30 06:00:34 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:34 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:34 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:34 volumio volumio[4024]: In UPNP mode
Oct 30 06:00:34 volumio volumio[4024]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1480,"duration":287,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1772 Kbps","isStreaming":false,"title":"驼铃","artist":"刘紫玲","album":"如歌岁月[Remaster]","uri":"http://192.168.1.17:39829/bridge-94.flac","trackType":"flac"}
Oct 30 06:00:34 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:34 volumio volumio[4024]: info: CoreStateMachine::syncState stateService pause
Oct 30 06:00:34 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play
Oct 30 06:00:34 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:34 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:34 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:34 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer
Oct 30 06:00:34 volumio volumio[4024]: info: ------------------------------ 3ms
Oct 30 06:00:34 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:34 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:34 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:44 volumio volumio[4024]: info:
Oct 30 06:00:44 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:44 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:44 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:44 volumio volumio[4024]: info: sendMpdCommand status took 1 milliseconds
Oct 30 06:00:44 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:44 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:44 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds
Oct 30 06:00:44 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:44 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:44 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:44 volumio volumio[4024]: info: CorePlayQueue::getTrack 0
Oct 30 06:00:44 volumio volumio[4024]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"驼铃","artist":"刘紫玲","album":"如歌岁月[Remaster]","uri":"http://192.168.1.17:39829/bridge-94.flac","trackType":"flac"}
Oct 30 06:00:44 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:44 volumio volumio[4024]: info: CoreStateMachine::syncState stateService stop
Oct 30 06:00:44 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play
Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:44 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer
Oct 30 06:00:44 volumio volumio[4024]: info: ------------------------------ 5ms
Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:44 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:44 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:44 volumio volumio[4024]: info: Clearing queue after UPNP request
Oct 30 06:00:45 volumio volumio[4024]: info: CoreStateMachine::ClearQueue
Oct 30 06:00:45 volumio volumio[4024]: info: CoreStateMachine::stop
Oct 30 06:00:45 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 30 06:00:45 volumio volumio[4024]: UNSET VOLATILE
Oct 30 06:00:45 volumio volumio[4024]: info: CorePlayQueue::clearPlayQueue
Oct 30 06:00:45 volumio volumio[4024]: info: CorePlayQueue::saveQueue
Oct 30 06:00:45 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:45 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:45 volumio volumio[4024]: info: CoreCommandRouter::volumioPushQueue
Oct 30 06:00:45 volumio volumio[4024]: info:
Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:45 volumio volumio[4024]: error: updateQueue error: null
Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:45 volumio volumio[4024]: info: Starting UPNP Playback
Oct 30 06:00:45 volumio volumio[4024]: info: Preparing playback through UPNP
Oct 30 06:00:45 volumio volumio[4024]: info: CoreCommandRouter::volumioGetState
Oct 30 06:00:45 volumio volumio[4024]: info: CorePlayQueue::getTrack 0
Oct 30 06:00:45 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 30 06:00:45 volumio volumio[4024]: info:
Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:45 volumio volumio[4024]: info:
Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:45 volumio volumio[4024]: info:
Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:45 volumio volumio[4024]: info:
Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:45 volumio volumio[4024]: info:
Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 0ms
Oct 30 06:00:45 volumio volumio[4024]: info:
Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update
Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update
Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 1ms
Oct 30 06:00:46 volumio volumio[4024]: info:
Oct 30 06:00:46 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:46 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:46 volumio volumio[4024]: info: sendMpdCommand status took 1 milliseconds
Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:46 volumio volumio[4024]: info:
Oct 30 06:00:46 volumio volumio[4024]: ---------------------------- MPD announces state update: player
Oct 30 06:00:46 volumio volumio[4024]: info: ControllerMpd::getState
Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status
Oct 30 06:00:46 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds
Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:46 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:46 volumio volumio[4024]: In UPNP mode
Oct 30 06:00:46 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. 你看你看月亮的脸","artist":"发烧对唱-那个季节里的歌","album":"童丽VS刘艺-那个季节里的歌5","uri":"http://192.168.1.17:37189/bridge-95.flac","trackType":"flac"}
Oct 30 06:00:46 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play
Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus stop
Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:46 volumio volumio[4024]: info: ------------------------------ 3ms
Oct 30 06:00:46 volumio volumio[4024]: info: sendMpdCommand status took 3 milliseconds
Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::parseState
Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 30 06:00:46 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo
Oct 30 06:00:46 volumio volumio[4024]: info: ControllerMpd::pushState
Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::servicePushState
Oct 30 06:00:46 volumio volumio[4024]: In UPNP mode
Oct 30 06:00:46 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"659 Kbps","isStreaming":false,"title":"01. 你看你看月亮的脸","artist":"发烧对唱-那个季节里的歌","album":"童丽VS刘艺-那个季节里的歌5","uri":"http://192.168.1.17:37189/bridge-95.flac","trackType":"flac"}
Oct 30 06:00:46 volumio volumio[4024]: verbose: CURRENT POSITION 0
Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play
Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play
Oct 30 06:00:46 volumio volumio[4024]: info: Received an update from plugin. extracting info from payload
Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::pushState
Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState
Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 30 06:00:46 volumio volumio[4024]: info: ------------------------------ 8ms
Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:46 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue
Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::getQueue
Oct 30 06:00:46 volumio volumio[4024]: info: CorePlayQueue::getQueue
Oct 30 06:01:04 volumio nmbd[895]: [2025/10/30 06:01:04.523191, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Oct 30 06:01:04 volumio nmbd[895]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.25 for name WORKGROUP<1d>.
Oct 30 06:01:04 volumio nmbd[895]: This response was from IP 192.168.1.20, reporting an IP address of 192.168.1.20.
Oct 30 06:01:53 volumio volumio[4024]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 30 06:01:53 volumio volumio[4024]: { Error: connect ETIMEDOUT 162.125.32.6:443
Oct 30 06:01:53 volumio volumio[4024]: at Object._errnoException (util.js:1022:11)
Oct 30 06:01:53 volumio volumio[4024]: at _exceptionWithHostPort (util.js:1044:20)
Oct 30 06:01:53 volumio volumio[4024]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Oct 30 06:01:53 volumio volumio[4024]: code: 'ETIMEDOUT',
Oct 30 06:01:53 volumio volumio[4024]: errno: 'ETIMEDOUT',
Oct 30 06:01:53 volumio volumio[4024]: syscall: 'connect',
Oct 30 06:01:53 volumio volumio[4024]: address: '162.125.32.6',
Oct 30 06:01:53 volumio volumio[4024]: port: 443 }
Oct 30 06:01:53 volumio volumio[4024]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 30 06:01:53 volumio sudo[28777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-30 06:00
Oct 30 06:01:53 volumio sudo[28777]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 8 (jessie)"
NAME="Debian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=debian
HOME_URL="http://www.debian.org/"
SUPPORT_URL="http://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="cd11dc738d0d82822d0aa776d0729686b82e3758"
VOLUMIO_FE_VERSION="537e3f50b5a8aa9bdf42f94adc80b348609b5c47"
VOLUMIO_BE_VERSION="d7e6c614214d5dc616fddcbcfefc47e1990da7b1"
VOLUMIO_ARCH="x86"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Sep 8 12:33:16 CEST 2021"
VOLUMIO_VERSION="2.909"
VOLUMIO_HARDWARE="x86"
VOLUMIO_HASH="6e5c976a6d85b8b7d7e4e3388d208cd8"