-- Logs begin at Sat 2025-09-13 09:08:39 CST, end at Sat 2025-09-13 09:13:41 CST. --
Sep 13 09:12:04 volumio volumio[898]: verbose: New Socket.io Connection to 192.168.50.52 from 192.168.50.192 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Mobile Safari/537.36 EdgA/137.0.0.0 Engine version: 3 Transport: polling Total Clients: 5
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::volumioGetState
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 13 09:12:04 volumio volumio[898]: info: Received Get System Info
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 13 09:12:04 volumio volumio[898]: info: Discovery: Getting this device information
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::volumioGetState
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::volumioGetState
Sep 13 09:12:04 volumio volumio[898]: info: Listing playlists
Sep 13 09:12:04 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Sep 13 09:12:55 volumio volumio[898]: info: Clearing queue after UPNP request
Sep 13 09:12:55 volumio volumio[898]: info: CoreStateMachine::ClearQueue
Sep 13 09:12:55 volumio volumio[898]: info: CoreStateMachine::stop
Sep 13 09:12:55 volumio volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 13 09:12:55 volumio volumio[898]: info: CorePlayQueue::clearPlayQueue
Sep 13 09:12:55 volumio volumio[898]: info: CorePlayQueue::saveQueue
Sep 13 09:12:55 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:12:55 volumio volumio[898]: info: CoreCommandRouter::volumioPushQueue
Sep 13 09:12:55 volumio volumio[898]: info:
Sep 13 09:12:55 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:55 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:55 volumio volumio[898]: info:
Sep 13 09:12:55 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:55 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:55 volumio volumio[898]: info:
Sep 13 09:12:55 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:55 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:55 volumio volumio[898]: error: updateQueue error: null
Sep 13 09:12:55 volumio volumio[898]: info: ------------------------------ 0ms
Sep 13 09:12:55 volumio volumio[898]: info: Starting UPNP Playback
Sep 13 09:12:55 volumio volumio[898]: info: Preparing playback through UPNP
Sep 13 09:12:55 volumio volumio[898]: info: CoreCommandRouter::volumioGetState
Sep 13 09:12:55 volumio volumio[898]: info: CorePlayQueue::getTrack 0
Sep 13 09:12:55 volumio volumio[898]: info: CoreStateMachine::setConsumeUpdateService mpd
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 1ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 1ms
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 0ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 0ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 0ms
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 1ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 1ms
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 0ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 0ms
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 1ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 0ms
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 1ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 1ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 1ms
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces system playlist update
Sep 13 09:12:56 volumio volumio[898]: info: Ignoring MPD Status Update
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 0ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 0ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 0ms
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces state update: player
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::getState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand status
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces state update: player
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::getState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand status
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces state update: player
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::getState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand status
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces state update: player
Sep 13 09:12:56 volumio volumio[898]: info: sendMpdCommand status took 4 milliseconds
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::getState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand status
Sep 13 09:12:56 volumio volumio[898]: info: sendMpdCommand status took 2 milliseconds
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::parseState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::parseState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces state update: player
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::getState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand status
Sep 13 09:12:56 volumio volumio[898]: info:
Sep 13 09:12:56 volumio volumio[898]: ---------------------------- MPD announces state update: player
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::getState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand status
Sep 13 09:12:56 volumio volumio[898]: info: sendMpdCommand status took 2 milliseconds
Sep 13 09:12:56 volumio volumio[898]: info: sendMpdCommand status took 1 milliseconds
Sep 13 09:12:56 volumio volumio[898]: info: sendMpdCommand playlistinfo took 1 milliseconds
Sep 13 09:12:56 volumio volumio[898]: info: sendMpdCommand status took 1 milliseconds
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::parseState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::parseState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::parseTrackInfo
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::parseState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::parseState
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::servicePushState
Sep 13 09:12:56 volumio volumio[898]: verbose: In UPNP mode
Sep 13 09:12:56 volumio volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":45,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"雾里","artist":"姚六一","album":"雾里","uri":"http://m702.music.126.net/20250913093755/60200859f931ff2935733eb995bd72da/jd-musicrep-ts/c493/3f00/9e4d/3c56c30cd924503f03ac7041ca1de39c.mp3?vuutv=HwB7ql4/LqLl7/QDtVNJhz/eBJI17mc9QxBMxrhMyS/2j0BgA0tIl3GO/ZFCw+rrylP4RFpfPTnx41/Xh048JuoY/xgKimKT3YNYIe+1ZTY=","trackType":""}
Sep 13 09:12:56 volumio volumio[898]: verbose: CURRENT POSITION 0
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState stateService play
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState currentStatus stop
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::servicePushState
Sep 13 09:12:56 volumio volumio[898]: verbose: In UPNP mode
Sep 13 09:12:56 volumio volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":45,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"雾里","artist":"姚六一","album":"雾里","uri":"http://m702.music.126.net/20250913093755/60200859f931ff2935733eb995bd72da/jd-musicrep-ts/c493/3f00/9e4d/3c56c30cd924503f03ac7041ca1de39c.mp3?vuutv=HwB7ql4/LqLl7/QDtVNJhz/eBJI17mc9QxBMxrhMyS/2j0BgA0tIl3GO/ZFCw+rrylP4RFpfPTnx41/Xh048JuoY/xgKimKT3YNYIe+1ZTY=","trackType":""}
Sep 13 09:12:56 volumio volumio[898]: verbose: CURRENT POSITION 0
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState stateService play
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState currentStatus play
Sep 13 09:12:56 volumio volumio[898]: info: Received an update from plugin. extracting info from payload
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 8ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 12ms
Sep 13 09:12:56 volumio volumio[898]: info: sendMpdCommand playlistinfo took 13 milliseconds
Sep 13 09:12:56 volumio volumio[898]: info: sendMpdCommand playlistinfo took 12 milliseconds
Sep 13 09:12:56 volumio volumio[898]: verbose: ControllerMpd::parseTrackInfo
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::servicePushState
Sep 13 09:12:56 volumio volumio[898]: verbose: In UPNP mode
Sep 13 09:12:56 volumio volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":45,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"雾里","artist":"姚六一","album":"雾里","uri":"http://m702.music.126.net/20250913093755/60200859f931ff2935733eb995bd72da/jd-musicrep-ts/c493/3f00/9e4d/3c56c30cd924503f03ac7041ca1de39c.mp3?vuutv=HwB7ql4/LqLl7/QDtVNJhz/eBJI17mc9QxBMxrhMyS/2j0BgA0tIl3GO/ZFCw+rrylP4RFpfPTnx41/Xh048JuoY/xgKimKT3YNYIe+1ZTY=","trackType":""}
Sep 13 09:12:56 volumio volumio[898]: verbose: CURRENT POSITION 0
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState stateService play
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState currentStatus play
Sep 13 09:12:56 volumio volumio[898]: info: Received an update from plugin. extracting info from payload
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::servicePushState
Sep 13 09:12:56 volumio volumio[898]: verbose: In UPNP mode
Sep 13 09:12:56 volumio volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":45,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"雾里","artist":"姚六一","album":"雾里","uri":"http://m702.music.126.net/20250913093755/60200859f931ff2935733eb995bd72da/jd-musicrep-ts/c493/3f00/9e4d/3c56c30cd924503f03ac7041ca1de39c.mp3?vuutv=HwB7ql4/LqLl7/QDtVNJhz/eBJI17mc9QxBMxrhMyS/2j0BgA0tIl3GO/ZFCw+rrylP4RFpfPTnx41/Xh048JuoY/xgKimKT3YNYIe+1ZTY=","trackType":""}
Sep 13 09:12:56 volumio volumio[898]: verbose: CURRENT POSITION 0
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState stateService play
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState currentStatus play
Sep 13 09:12:56 volumio volumio[898]: info: Received an update from plugin. extracting info from payload
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::servicePushState
Sep 13 09:12:56 volumio volumio[898]: verbose: In UPNP mode
Sep 13 09:12:56 volumio volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":45,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"雾里","artist":"姚六一","album":"雾里","uri":"http://m702.music.126.net/20250913093755/60200859f931ff2935733eb995bd72da/jd-musicrep-ts/c493/3f00/9e4d/3c56c30cd924503f03ac7041ca1de39c.mp3?vuutv=HwB7ql4/LqLl7/QDtVNJhz/eBJI17mc9QxBMxrhMyS/2j0BgA0tIl3GO/ZFCw+rrylP4RFpfPTnx41/Xh048JuoY/xgKimKT3YNYIe+1ZTY=","trackType":""}
Sep 13 09:12:56 volumio volumio[898]: verbose: CURRENT POSITION 0
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState stateService play
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState currentStatus play
Sep 13 09:12:56 volumio volumio[898]: info: Received an update from plugin. extracting info from payload
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:12:56 volumio volumio[898]: info: ControllerMpd::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::servicePushState
Sep 13 09:12:56 volumio volumio[898]: verbose: In UPNP mode
Sep 13 09:12:56 volumio volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":45,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"雾里","artist":"姚六一","album":"雾里","uri":"http://m702.music.126.net/20250913093755/60200859f931ff2935733eb995bd72da/jd-musicrep-ts/c493/3f00/9e4d/3c56c30cd924503f03ac7041ca1de39c.mp3?vuutv=HwB7ql4/LqLl7/QDtVNJhz/eBJI17mc9QxBMxrhMyS/2j0BgA0tIl3GO/ZFCw+rrylP4RFpfPTnx41/Xh048JuoY/xgKimKT3YNYIe+1ZTY=","trackType":""}
Sep 13 09:12:56 volumio volumio[898]: verbose: CURRENT POSITION 0
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState stateService play
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::syncState currentStatus play
Sep 13 09:12:56 volumio volumio[898]: info: Received an update from plugin. extracting info from payload
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 49ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 49ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 48ms
Sep 13 09:12:56 volumio volumio[898]: info: ------------------------------ 48ms
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CorePlayQueue::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CorePlayQueue::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CorePlayQueue::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CorePlayQueue::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CorePlayQueue::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CorePlayQueue::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CorePlayQueue::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CorePlayQueue::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CorePlayQueue::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue
Sep 13 09:12:56 volumio volumio[898]: info: CoreStateMachine::getQueue
Sep 13 09:12:56 volumio volumio[898]: info: CorePlayQueue::getQueue
Sep 13 09:13:41 volumio volumio[898]: info:
Sep 13 09:13:41 volumio volumio[898]: ---------------------------- MPD announces state update: player
Sep 13 09:13:41 volumio volumio[898]: info: ControllerMpd::getState
Sep 13 09:13:41 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand status
Sep 13 09:13:41 volumio volumio[898]: info:
Sep 13 09:13:41 volumio volumio[898]: ---------------------------- MPD announces state update: player
Sep 13 09:13:41 volumio volumio[898]: info: ControllerMpd::getState
Sep 13 09:13:41 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand status
Sep 13 09:13:41 volumio volumio[898]: info:
Sep 13 09:13:41 volumio volumio[898]: ---------------------------- MPD announces state update: player
Sep 13 09:13:41 volumio volumio[898]: info: ControllerMpd::getState
Sep 13 09:13:41 volumio volumio[898]: verbose: ControllerMpd::sendMpdCommand status
Sep 13 09:13:41 volumio volumio[898]: info: sendMpdCommand status took 1 milliseconds
Sep 13 09:13:41 volumio volumio[898]: verbose: ControllerMpd::parseState
Sep 13 09:13:41 volumio volumio[898]: info: ControllerMpd::pushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::servicePushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:13:41 volumio volumio[898]: info: CorePlayQueue::getTrack 0
Sep 13 09:13:41 volumio volumio[898]: 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}
Sep 13 09:13:41 volumio volumio[898]: verbose: CURRENT POSITION 0
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::syncState stateService stop
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::syncState currentStatus play
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::stPlaybackTimer
Sep 13 09:13:41 volumio volumio[898]: info: ControllerMpd::pushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::servicePushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:13:41 volumio volumio[898]: info: CorePlayQueue::getTrack 0
Sep 13 09:13:41 volumio volumio[898]: 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}
Sep 13 09:13:41 volumio volumio[898]: verbose: CURRENT POSITION 0
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::syncState stateService stop
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::syncState currentStatus stop
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:13:41 volumio volumio[898]: info: No code
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:13:41 volumio volumio[898]: info: ControllerMpd::pushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::servicePushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:13:41 volumio volumio[898]: info: CorePlayQueue::getTrack 0
Sep 13 09:13:41 volumio volumio[898]: 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}
Sep 13 09:13:41 volumio volumio[898]: verbose: CURRENT POSITION 0
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::syncState stateService stop
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::syncState currentStatus stop
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:13:41 volumio volumio[898]: info: No code
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::pushState
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::volumioPushState
Sep 13 09:13:41 volumio volumio[898]: info: ------------------------------ 16ms
Sep 13 09:13:41 volumio volumio[898]: info: ------------------------------ 17ms
Sep 13 09:13:41 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue
Sep 13 09:13:41 volumio volumio[898]: info: CoreStateMachine::getQueue
Sep 13 09:13:41 volumio volumio[898]: info: CorePlayQueue::getQueue
Sep 13 09:13:41 volumio volumio[898]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 13 09:13:41 volumio volumio[898]: Error: connect ETIMEDOUT 157.240.17.41:443
Sep 13 09:13:41 volumio volumio[898]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Sep 13 09:13:41 volumio volumio[898]: errno: -110,
Sep 13 09:13:41 volumio volumio[898]: code: 'ETIMEDOUT',
Sep 13 09:13:41 volumio volumio[898]: syscall: 'connect',
Sep 13 09:13:41 volumio volumio[898]: address: '157.240.17.41',
Sep 13 09:13:41 volumio volumio[898]: port: 443
Sep 13 09:13:41 volumio volumio[898]: }
Sep 13 09:13:41 volumio volumio[898]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 13 09:13:41 volumio sudo[2825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-13 09:12
Sep 13 09:13:41 volumio sudo[2825]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"