-- Logs begin at Sun 2025-10-26 04:47:49 UTC, end at Sun 2025-10-26 06:36:58 UTC. --
Oct 26 06:35:00 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 26 06:35:04 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 26 06:35:07 volumio volumio[680]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jacqueline%20du%20Pr%C3%A9/Jacqueline%20du%20Pr%C3%A9%3A%20The%20Complete%20EMI%20Recordings/07d58b4f-e779-4fb5-b44e-e008ea0a4f57.jpg'
Oct 26 06:35:08 volumio volumio[680]: info:
Oct 26 06:35:08 volumio volumio[680]: ---------------------------- MPD announces state update: player
Oct 26 06:35:08 volumio volumio[680]: info: ControllerMpd::getState
Oct 26 06:35:08 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 06:35:08 volumio volumio[680]: info: sendMpdCommand status took 2 milliseconds
Oct 26 06:35:08 volumio volumio[680]: verbose: ControllerMpd::parseState
Oct 26 06:35:08 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 06:35:08 volumio volumio[680]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 26 06:35:08 volumio volumio[680]: verbose: ControllerMpd::parseTrackInfo
Oct 26 06:35:08 volumio volumio[680]: info: ControllerMpd::pushState
Oct 26 06:35:08 volumio volumio[680]: info: CoreCommandRouter::servicePushState
Oct 26 06:35:08 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:35:08 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:35:08 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:35:08 volumio volumio[680]: info: CorePlayQueue::getTrack 7
Oct 26 06:35:08 volumio volumio[680]: 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":"Song without Words in D Op.109","artist":"Jacqueline du Pré","album":"Jacqueline du Pré: The Complete EMI Recordings","uri":"http://m801.music.126.net/20251026145929/78b01a646a9762dfc6b267769b6eaf3a/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/34539997372/b3e1/0f2a/cc4c/a361633034f7a6f908fb2c71bafa096d.mp3?vuutv=W5jRmRBwbeJA3iZzzhXzWPuwIPKG5O/0jBGcvysL6cQgXDT42IISGaWTGHG3GE9k1PmJ79t2XH2KiMJ904w2wEG0QNdMUggULhtNmyx2Fcg=","trackType":""}
Oct 26 06:35:08 volumio volumio[680]: verbose: CURRENT POSITION 7
Oct 26 06:35:08 volumio volumio[680]: info: CoreStateMachine::syncState   stateService stop
Oct 26 06:35:08 volumio volumio[680]: info: CoreStateMachine::syncState   currentStatus play
Oct 26 06:35:08 volumio volumio[680]: info: CoreStateMachine::play index undefined
Oct 26 06:35:08 volumio volumio[680]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 06:35:08 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:35:08 volumio volumio[680]: info: CorePlayQueue::getTrack 0
Oct 26 06:35:08 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:35:08 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:35:08 volumio volumio[680]: info: CorePlayQueue::getTrack 0
Oct 26 06:35:08 volumio volumio[680]: info: ------------------------------ 36ms
Oct 26 06:35:08 volumio volumio[680]: info: CoreCommandRouter::volumioGetQueue
Oct 26 06:35:08 volumio volumio[680]: info: CoreStateMachine::getQueue
Oct 26 06:35:08 volumio volumio[680]: info: CorePlayQueue::getQueue
Oct 26 06:35:08 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 26 06:35:08 volumio volumio[680]: info: Clearing queue after UPNP request
Oct 26 06:35:08 volumio volumio[680]: info: CoreStateMachine::ClearQueue
Oct 26 06:35:08 volumio volumio[680]: info: CoreStateMachine::stop
Oct 26 06:35:08 volumio volumio[680]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 06:35:08 volumio volumio[680]: info: CorePlayQueue::clearPlayQueue
Oct 26 06:35:08 volumio volumio[680]: info: CorePlayQueue::saveQueue
Oct 26 06:35:08 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:35:08 volumio volumio[680]: info: CoreCommandRouter::volumioPushQueue
Oct 26 06:35:08 volumio volumio[680]: info:
Oct 26 06:35:08 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:35:08 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:35:08 volumio volumio[680]: error: updateQueue error: null
Oct 26 06:35:08 volumio volumio[680]: info: ------------------------------ 3ms
Oct 26 06:35:08 volumio volumio[680]: info: Starting UPNP Playback
Oct 26 06:35:08 volumio volumio[680]: info: Preparing playback through UPNP
Oct 26 06:35:08 volumio volumio[680]: info: CoreCommandRouter::volumioGetState
Oct 26 06:35:08 volumio volumio[680]: info: CorePlayQueue::getTrack 0
Oct 26 06:35:08 volumio volumio[680]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 26 06:35:09 volumio volumio[680]: info:
Oct 26 06:35:09 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:35:09 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:35:09 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:35:09 volumio volumio[680]: info:
Oct 26 06:35:09 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:35:09 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:35:09 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:35:09 volumio volumio[680]: info:
Oct 26 06:35:09 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:35:09 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:35:09 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:35:09 volumio volumio[680]: info:
Oct 26 06:35:09 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:35:09 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:35:09 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:35:09 volumio volumio[680]: info:
Oct 26 06:35:09 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:35:09 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:35:09 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:35:09 volumio volumio[680]: info:
Oct 26 06:35:09 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:35:09 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:35:09 volumio volumio[680]: info: ------------------------------ 1ms
Oct 26 06:35:09 volumio volumio[680]: info:
Oct 26 06:35:09 volumio volumio[680]: ---------------------------- MPD announces state update: player
Oct 26 06:35:09 volumio volumio[680]: info: ControllerMpd::getState
Oct 26 06:35:09 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 06:35:09 volumio volumio[680]: info: sendMpdCommand status took 33 milliseconds
Oct 26 06:35:09 volumio volumio[680]: verbose: ControllerMpd::parseState
Oct 26 06:35:09 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 06:35:09 volumio volumio[680]: info:
Oct 26 06:35:09 volumio volumio[680]: ---------------------------- MPD announces state update: player
Oct 26 06:35:09 volumio volumio[680]: info: ControllerMpd::getState
Oct 26 06:35:09 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 06:35:09 volumio volumio[680]: info: sendMpdCommand playlistinfo took 6 milliseconds
Oct 26 06:35:09 volumio volumio[680]: info: sendMpdCommand status took 3 milliseconds
Oct 26 06:35:09 volumio volumio[680]: verbose: ControllerMpd::parseTrackInfo
Oct 26 06:35:09 volumio volumio[680]: verbose: ControllerMpd::parseState
Oct 26 06:35:09 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 06:35:09 volumio volumio[680]: info: ControllerMpd::pushState
Oct 26 06:35:09 volumio volumio[680]: info: CoreCommandRouter::servicePushState
Oct 26 06:35:09 volumio volumio[680]: verbose: In UPNP mode
Oct 26 06:35:09 volumio volumio[680]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":406,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Elegie in C Minor Op. 24","artist":"Jacqueline du Pré","album":"Jacqueline du Pré: The Complete EMI Recordings","uri":"http://m701.music.126.net/20251026150008/2dce1333851e4c529e99109fc4f1bbff/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/44070635838/ee6b/43cf/64db/aa706e4de582f44964eb95298870ea87.mp3?vuutv=9HkXEDLhfmr7vRFU2628WVqfYPwSg3uXZA4uN4DHT8e7mOXJrPBe9G2++fCGK7xwT9LOJDwPh1szcmKnsYRKVBoaxC/azkKDD9TZwhWUqOA=","trackType":""}
Oct 26 06:35:09 volumio volumio[680]: verbose: CURRENT POSITION 0
Oct 26 06:35:09 volumio volumio[680]: info: CoreStateMachine::syncState   stateService play
Oct 26 06:35:09 volumio volumio[680]: info: CoreStateMachine::syncState   currentStatus stop
Oct 26 06:35:09 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:35:09 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:35:09 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:35:09 volumio volumio[680]: info: ------------------------------ 73ms
Oct 26 06:35:09 volumio volumio[680]: info: sendMpdCommand playlistinfo took 24 milliseconds
Oct 26 06:35:09 volumio volumio[680]: verbose: ControllerMpd::parseTrackInfo
Oct 26 06:35:09 volumio volumio[680]: info: ControllerMpd::pushState
Oct 26 06:35:09 volumio volumio[680]: info: CoreCommandRouter::servicePushState
Oct 26 06:35:09 volumio volumio[680]: verbose: In UPNP mode
Oct 26 06:35:09 volumio volumio[680]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":406,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Elegie in C Minor Op. 24","artist":"Jacqueline du Pré","album":"Jacqueline du Pré: The Complete EMI Recordings","uri":"http://m701.music.126.net/20251026150008/2dce1333851e4c529e99109fc4f1bbff/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/44070635838/ee6b/43cf/64db/aa706e4de582f44964eb95298870ea87.mp3?vuutv=9HkXEDLhfmr7vRFU2628WVqfYPwSg3uXZA4uN4DHT8e7mOXJrPBe9G2++fCGK7xwT9LOJDwPh1szcmKnsYRKVBoaxC/azkKDD9TZwhWUqOA=","trackType":""}
Oct 26 06:35:09 volumio volumio[680]: verbose: CURRENT POSITION 0
Oct 26 06:35:09 volumio volumio[680]: info: CoreStateMachine::syncState   stateService play
Oct 26 06:35:09 volumio volumio[680]: info: CoreStateMachine::syncState   currentStatus play
Oct 26 06:35:09 volumio volumio[680]: info: Received an update from plugin. extracting info from payload
Oct 26 06:35:09 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 26 06:35:09 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:35:09 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:35:09 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:35:09 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:35:09 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:35:09 volumio volumio[680]: info: ------------------------------ 60ms
Oct 26 06:35:09 volumio volumio[680]: info: CoreCommandRouter::volumioGetQueue
Oct 26 06:35:09 volumio volumio[680]: info: CoreStateMachine::getQueue
Oct 26 06:35:09 volumio volumio[680]: info: CorePlayQueue::getQueue
Oct 26 06:35:09 volumio volumio[680]: info: CoreCommandRouter::volumioGetQueue
Oct 26 06:35:09 volumio volumio[680]: info: CoreStateMachine::getQueue
Oct 26 06:35:09 volumio volumio[680]: info: CorePlayQueue::getQueue
Oct 26 06:35:12 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 26 06:36:14 volumio volumio[680]: info:
Oct 26 06:36:14 volumio volumio[680]: ---------------------------- MPD announces state update: player
Oct 26 06:36:14 volumio volumio[680]: info: ControllerMpd::getState
Oct 26 06:36:14 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 06:36:14 volumio volumio[680]: info: sendMpdCommand status took 3 milliseconds
Oct 26 06:36:14 volumio volumio[680]: verbose: ControllerMpd::parseState
Oct 26 06:36:14 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 06:36:14 volumio volumio[680]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 26 06:36:14 volumio volumio[680]: verbose: ControllerMpd::parseTrackInfo
Oct 26 06:36:14 volumio volumio[680]: info: ControllerMpd::pushState
Oct 26 06:36:14 volumio volumio[680]: info: CoreCommandRouter::servicePushState
Oct 26 06:36:14 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:36:14 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:36:14 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:14 volumio volumio[680]: info: CorePlayQueue::getTrack 0
Oct 26 06:36:14 volumio volumio[680]: 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":"Elegie in C Minor Op. 24","artist":"Jacqueline du Pré","album":"Jacqueline du Pré: The Complete EMI Recordings","uri":"http://m701.music.126.net/20251026150008/2dce1333851e4c529e99109fc4f1bbff/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/44070635838/ee6b/43cf/64db/aa706e4de582f44964eb95298870ea87.mp3?vuutv=9HkXEDLhfmr7vRFU2628WVqfYPwSg3uXZA4uN4DHT8e7mOXJrPBe9G2++fCGK7xwT9LOJDwPh1szcmKnsYRKVBoaxC/azkKDD9TZwhWUqOA=","trackType":""}
Oct 26 06:36:14 volumio volumio[680]: verbose: CURRENT POSITION 0
Oct 26 06:36:14 volumio volumio[680]: info: CoreStateMachine::syncState   stateService stop
Oct 26 06:36:14 volumio volumio[680]: info: CoreStateMachine::syncState   currentStatus play
Oct 26 06:36:14 volumio volumio[680]: info: CoreStateMachine::play index undefined
Oct 26 06:36:14 volumio volumio[680]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 06:36:14 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:36:14 volumio volumio[680]: info: CorePlayQueue::getTrack 0
Oct 26 06:36:14 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:36:14 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:14 volumio volumio[680]: info: CorePlayQueue::getTrack 0
Oct 26 06:36:14 volumio volumio[680]: info: ------------------------------ 19ms
Oct 26 06:36:14 volumio volumio[680]: info: CoreCommandRouter::volumioGetQueue
Oct 26 06:36:14 volumio volumio[680]: info: CoreStateMachine::getQueue
Oct 26 06:36:14 volumio volumio[680]: info: CorePlayQueue::getQueue
Oct 26 06:36:14 volumio volumio[680]: info: Clearing queue after UPNP request
Oct 26 06:36:15 volumio volumio[680]: info: CoreStateMachine::ClearQueue
Oct 26 06:36:15 volumio volumio[680]: info: CoreStateMachine::stop
Oct 26 06:36:15 volumio volumio[680]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 06:36:15 volumio volumio[680]: info: CorePlayQueue::clearPlayQueue
Oct 26 06:36:15 volumio volumio[680]: info: CorePlayQueue::saveQueue
Oct 26 06:36:15 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:15 volumio volumio[680]: info: CoreCommandRouter::volumioPushQueue
Oct 26 06:36:15 volumio volumio[680]: info:
Oct 26 06:36:15 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:15 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:15 volumio volumio[680]: error: updateQueue error: null
Oct 26 06:36:15 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:36:15 volumio volumio[680]: info: Starting UPNP Playback
Oct 26 06:36:15 volumio volumio[680]: info: Preparing playback through UPNP
Oct 26 06:36:15 volumio volumio[680]: info: CoreCommandRouter::volumioGetState
Oct 26 06:36:15 volumio volumio[680]: info: CorePlayQueue::getTrack 0
Oct 26 06:36:15 volumio volumio[680]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 26 06:36:15 volumio volumio[680]: info:
Oct 26 06:36:15 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:15 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:15 volumio volumio[680]: info: ------------------------------ 1ms
Oct 26 06:36:15 volumio volumio[680]: info:
Oct 26 06:36:15 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:15 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:15 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:36:15 volumio volumio[680]: info:
Oct 26 06:36:15 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:15 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:15 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:36:15 volumio volumio[680]: info:
Oct 26 06:36:15 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:15 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:15 volumio volumio[680]: info:
Oct 26 06:36:15 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:15 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:15 volumio volumio[680]: info: ------------------------------ 3ms
Oct 26 06:36:15 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:36:15 volumio volumio[680]: info:
Oct 26 06:36:15 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:15 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:15 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:36:16 volumio volumio[680]: info:
Oct 26 06:36:16 volumio volumio[680]: ---------------------------- MPD announces state update: player
Oct 26 06:36:16 volumio volumio[680]: info: ControllerMpd::getState
Oct 26 06:36:16 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 06:36:16 volumio volumio[680]: info:
Oct 26 06:36:16 volumio volumio[680]: ---------------------------- MPD announces state update: player
Oct 26 06:36:16 volumio volumio[680]: info: sendMpdCommand status took 40 milliseconds
Oct 26 06:36:16 volumio volumio[680]: info: ControllerMpd::getState
Oct 26 06:36:16 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 06:36:16 volumio volumio[680]: verbose: ControllerMpd::parseState
Oct 26 06:36:16 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 06:36:16 volumio volumio[680]: info: sendMpdCommand status took 2 milliseconds
Oct 26 06:36:16 volumio volumio[680]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 26 06:36:16 volumio volumio[680]: verbose: ControllerMpd::parseState
Oct 26 06:36:16 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 06:36:16 volumio volumio[680]: verbose: ControllerMpd::parseTrackInfo
Oct 26 06:36:16 volumio volumio[680]: info: ControllerMpd::pushState
Oct 26 06:36:16 volumio volumio[680]: info: CoreCommandRouter::servicePushState
Oct 26 06:36:16 volumio volumio[680]: verbose: In UPNP mode
Oct 26 06:36:16 volumio volumio[680]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":172,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Fantasiestücke Op.73:I. Zart und mit Ausdruck","artist":"Jacqueline du Pré","album":"Jacqueline du Pré: The Complete EMI Recordings","uri":"http://m701.music.126.net/20251026145911/1da28165c2c773cc43908e3751677e23/jdyyaac/055a/010f/555f/20c8c05f2f6ef25586f2b5b7bcb37d42.m4a?vuutv=BQNLxBYI7J98YiGTqwMlnAkdeE5w53izw69sQo43zsHqaz9RjpdvUDHcuSEZTNVc6/I4TM07VuGLZGRweMuL737aiVxJc9QArWXCzlvoNbw=","trackType":""}
Oct 26 06:36:16 volumio volumio[680]: verbose: CURRENT POSITION 0
Oct 26 06:36:16 volumio volumio[680]: info: CoreStateMachine::syncState   stateService play
Oct 26 06:36:16 volumio volumio[680]: info: CoreStateMachine::syncState   currentStatus stop
Oct 26 06:36:16 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:36:16 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:36:16 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:16 volumio volumio[680]: info: ------------------------------ 62ms
Oct 26 06:36:16 volumio volumio[680]: info: sendMpdCommand playlistinfo took 19 milliseconds
Oct 26 06:36:16 volumio volumio[680]: verbose: ControllerMpd::parseTrackInfo
Oct 26 06:36:16 volumio volumio[680]: info: ControllerMpd::pushState
Oct 26 06:36:16 volumio volumio[680]: info: CoreCommandRouter::servicePushState
Oct 26 06:36:16 volumio volumio[680]: verbose: In UPNP mode
Oct 26 06:36:16 volumio volumio[680]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":172,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Fantasiestücke Op.73:I. Zart und mit Ausdruck","artist":"Jacqueline du Pré","album":"Jacqueline du Pré: The Complete EMI Recordings","uri":"http://m701.music.126.net/20251026145911/1da28165c2c773cc43908e3751677e23/jdyyaac/055a/010f/555f/20c8c05f2f6ef25586f2b5b7bcb37d42.m4a?vuutv=BQNLxBYI7J98YiGTqwMlnAkdeE5w53izw69sQo43zsHqaz9RjpdvUDHcuSEZTNVc6/I4TM07VuGLZGRweMuL737aiVxJc9QArWXCzlvoNbw=","trackType":""}
Oct 26 06:36:16 volumio volumio[680]: verbose: CURRENT POSITION 0
Oct 26 06:36:16 volumio volumio[680]: info: CoreStateMachine::syncState   stateService play
Oct 26 06:36:16 volumio volumio[680]: info: CoreStateMachine::syncState   currentStatus play
Oct 26 06:36:16 volumio volumio[680]: info: Received an update from plugin. extracting info from payload
Oct 26 06:36:16 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 26 06:36:16 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:36:16 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:36:16 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:16 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:36:16 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:16 volumio volumio[680]: info: ------------------------------ 42ms
Oct 26 06:36:16 volumio volumio[680]: info: CoreCommandRouter::volumioGetQueue
Oct 26 06:36:16 volumio volumio[680]: info: CoreStateMachine::getQueue
Oct 26 06:36:16 volumio volumio[680]: info: CorePlayQueue::getQueue
Oct 26 06:36:16 volumio volumio[680]: info: CoreCommandRouter::volumioGetQueue
Oct 26 06:36:16 volumio volumio[680]: info: CoreStateMachine::getQueue
Oct 26 06:36:16 volumio volumio[680]: info: CorePlayQueue::getQueue
Oct 26 06:36:53 volumio volumio[680]: info:
Oct 26 06:36:53 volumio volumio[680]: ---------------------------- MPD announces state update: player
Oct 26 06:36:53 volumio volumio[680]: info: ControllerMpd::getState
Oct 26 06:36:53 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 06:36:53 volumio volumio[680]: info: sendMpdCommand status took 3 milliseconds
Oct 26 06:36:53 volumio volumio[680]: verbose: ControllerMpd::parseState
Oct 26 06:36:53 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 06:36:53 volumio volumio[680]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 26 06:36:53 volumio volumio[680]: verbose: ControllerMpd::parseTrackInfo
Oct 26 06:36:53 volumio volumio[680]: info: ControllerMpd::pushState
Oct 26 06:36:53 volumio volumio[680]: info: CoreCommandRouter::servicePushState
Oct 26 06:36:53 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:36:53 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:36:53 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:53 volumio volumio[680]: info: CorePlayQueue::getTrack 0
Oct 26 06:36:53 volumio volumio[680]: 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":"Fantasiestücke Op.73:I. Zart und mit Ausdruck","artist":"Jacqueline du Pré","album":"Jacqueline du Pré: The Complete EMI Recordings","uri":"http://m701.music.126.net/20251026145911/1da28165c2c773cc43908e3751677e23/jdyyaac/055a/010f/555f/20c8c05f2f6ef25586f2b5b7bcb37d42.m4a?vuutv=BQNLxBYI7J98YiGTqwMlnAkdeE5w53izw69sQo43zsHqaz9RjpdvUDHcuSEZTNVc6/I4TM07VuGLZGRweMuL737aiVxJc9QArWXCzlvoNbw=","trackType":""}
Oct 26 06:36:53 volumio volumio[680]: verbose: CURRENT POSITION 0
Oct 26 06:36:53 volumio volumio[680]: info: CoreStateMachine::syncState   stateService stop
Oct 26 06:36:53 volumio volumio[680]: info: CoreStateMachine::syncState   currentStatus play
Oct 26 06:36:53 volumio volumio[680]: info: CoreStateMachine::play index undefined
Oct 26 06:36:53 volumio volumio[680]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 06:36:53 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:36:53 volumio volumio[680]: info: CorePlayQueue::getTrack 0
Oct 26 06:36:53 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:36:53 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:53 volumio volumio[680]: info: CorePlayQueue::getTrack 0
Oct 26 06:36:53 volumio volumio[680]: info: ------------------------------ 23ms
Oct 26 06:36:53 volumio volumio[680]: info: CoreCommandRouter::volumioGetQueue
Oct 26 06:36:53 volumio volumio[680]: info: CoreStateMachine::getQueue
Oct 26 06:36:53 volumio volumio[680]: info: CorePlayQueue::getQueue
Oct 26 06:36:54 volumio volumio[680]: info: Clearing queue after UPNP request
Oct 26 06:36:54 volumio volumio[680]: info: CoreStateMachine::ClearQueue
Oct 26 06:36:54 volumio volumio[680]: info: CoreStateMachine::stop
Oct 26 06:36:54 volumio volumio[680]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 06:36:54 volumio volumio[680]: info: CorePlayQueue::clearPlayQueue
Oct 26 06:36:54 volumio volumio[680]: info: CorePlayQueue::saveQueue
Oct 26 06:36:54 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:54 volumio volumio[680]: info: CoreCommandRouter::volumioPushQueue
Oct 26 06:36:54 volumio volumio[680]: info:
Oct 26 06:36:54 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:54 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:54 volumio volumio[680]: error: updateQueue error: null
Oct 26 06:36:54 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:36:54 volumio volumio[680]: info: Starting UPNP Playback
Oct 26 06:36:54 volumio volumio[680]: info: Preparing playback through UPNP
Oct 26 06:36:54 volumio volumio[680]: info: CoreCommandRouter::volumioGetState
Oct 26 06:36:54 volumio volumio[680]: info: CorePlayQueue::getTrack 0
Oct 26 06:36:54 volumio volumio[680]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 26 06:36:54 volumio volumio[680]: info:
Oct 26 06:36:54 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:54 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:54 volumio volumio[680]: info:
Oct 26 06:36:54 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:54 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:54 volumio volumio[680]: info: ------------------------------ 4ms
Oct 26 06:36:54 volumio volumio[680]: info: ------------------------------ 3ms
Oct 26 06:36:54 volumio volumio[680]: info:
Oct 26 06:36:54 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:54 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:54 volumio volumio[680]: info: ------------------------------ 1ms
Oct 26 06:36:54 volumio volumio[680]: info:
Oct 26 06:36:54 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:54 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:54 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:36:54 volumio volumio[680]: info:
Oct 26 06:36:54 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:54 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:54 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:36:54 volumio volumio[680]: info:
Oct 26 06:36:54 volumio volumio[680]: ---------------------------- MPD announces system playlist update
Oct 26 06:36:54 volumio volumio[680]: info: Ignoring MPD Status Update
Oct 26 06:36:54 volumio volumio[680]: info: ------------------------------ 2ms
Oct 26 06:36:55 volumio volumio[680]: info:
Oct 26 06:36:55 volumio volumio[680]: ---------------------------- MPD announces state update: player
Oct 26 06:36:55 volumio volumio[680]: info: ControllerMpd::getState
Oct 26 06:36:55 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 06:36:55 volumio volumio[680]: info:
Oct 26 06:36:55 volumio volumio[680]: ---------------------------- MPD announces state update: player
Oct 26 06:36:55 volumio volumio[680]: info: sendMpdCommand status took 38 milliseconds
Oct 26 06:36:55 volumio volumio[680]: info: ControllerMpd::getState
Oct 26 06:36:55 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 06:36:55 volumio volumio[680]: verbose: ControllerMpd::parseState
Oct 26 06:36:55 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 06:36:55 volumio volumio[680]: info: sendMpdCommand status took 5 milliseconds
Oct 26 06:36:55 volumio volumio[680]: info: sendMpdCommand playlistinfo took 6 milliseconds
Oct 26 06:36:55 volumio volumio[680]: verbose: ControllerMpd::parseState
Oct 26 06:36:55 volumio volumio[680]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 06:36:55 volumio volumio[680]: verbose: ControllerMpd::parseTrackInfo
Oct 26 06:36:55 volumio volumio[680]: info: ControllerMpd::pushState
Oct 26 06:36:55 volumio volumio[680]: info: CoreCommandRouter::servicePushState
Oct 26 06:36:55 volumio volumio[680]: verbose: In UPNP mode
Oct 26 06:36:55 volumio volumio[680]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":335,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Song without Words in D Op.109","artist":"Jacqueline du Pré","album":"Jacqueline du Pré: The Complete EMI Recordings","uri":"http://m701.music.126.net/20251026150154/bd3a855157a472220da0fa91ee2b4ad2/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/34539997372/b3e1/0f2a/cc4c/a361633034f7a6f908fb2c71bafa096d.mp3?vuutv=CKfKRd6H+ZIFRuPdZHtL0srBGNvR7okslAqPX0WyeJz4tPU117/JXJaRa4btOBi0lCGQ8Mx0p9VCDITV+lSH6jdNopS6tS623sQNMtE907U=","trackType":""}
Oct 26 06:36:55 volumio volumio[680]: verbose: CURRENT POSITION 0
Oct 26 06:36:55 volumio volumio[680]: info: CoreStateMachine::syncState   stateService play
Oct 26 06:36:55 volumio volumio[680]: info: CoreStateMachine::syncState   currentStatus stop
Oct 26 06:36:55 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:36:55 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:36:55 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:55 volumio volumio[680]: info: ------------------------------ 65ms
Oct 26 06:36:55 volumio volumio[680]: info: sendMpdCommand playlistinfo took 18 milliseconds
Oct 26 06:36:55 volumio volumio[680]: verbose: ControllerMpd::parseTrackInfo
Oct 26 06:36:55 volumio volumio[680]: info: ControllerMpd::pushState
Oct 26 06:36:55 volumio volumio[680]: info: CoreCommandRouter::servicePushState
Oct 26 06:36:55 volumio volumio[680]: verbose: In UPNP mode
Oct 26 06:36:55 volumio volumio[680]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":335,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Song without Words in D Op.109","artist":"Jacqueline du Pré","album":"Jacqueline du Pré: The Complete EMI Recordings","uri":"http://m701.music.126.net/20251026150154/bd3a855157a472220da0fa91ee2b4ad2/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/34539997372/b3e1/0f2a/cc4c/a361633034f7a6f908fb2c71bafa096d.mp3?vuutv=CKfKRd6H+ZIFRuPdZHtL0srBGNvR7okslAqPX0WyeJz4tPU117/JXJaRa4btOBi0lCGQ8Mx0p9VCDITV+lSH6jdNopS6tS623sQNMtE907U=","trackType":""}
Oct 26 06:36:55 volumio volumio[680]: verbose: CURRENT POSITION 0
Oct 26 06:36:55 volumio volumio[680]: info: CoreStateMachine::syncState   stateService play
Oct 26 06:36:55 volumio volumio[680]: info: CoreStateMachine::syncState   currentStatus play
Oct 26 06:36:55 volumio volumio[680]: info: Received an update from plugin. extracting info from payload
Oct 26 06:36:55 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 26 06:36:55 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:36:55 volumio volumio[680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 06:36:55 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:55 volumio volumio[680]: info: CoreStateMachine::pushState
Oct 26 06:36:55 volumio volumio[680]: info: CoreCommandRouter::volumioPushState
Oct 26 06:36:55 volumio volumio[680]: info: ------------------------------ 49ms
Oct 26 06:36:55 volumio volumio[680]: info: CoreCommandRouter::volumioGetQueue
Oct 26 06:36:55 volumio volumio[680]: info: CoreStateMachine::getQueue
Oct 26 06:36:55 volumio volumio[680]: info: CorePlayQueue::getQueue
Oct 26 06:36:55 volumio volumio[680]: info: CoreCommandRouter::volumioGetQueue
Oct 26 06:36:55 volumio volumio[680]: info: CoreStateMachine::getQueue
Oct 26 06:36:55 volumio volumio[680]: info: CorePlayQueue::getQueue
Oct 26 06:36:58 volumio volumio[680]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 26 06:36:58 volumio volumio[680]: Error: connect ETIMEDOUT 199.59.149.208:443
Oct 26 06:36:58 volumio volumio[680]:     at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Oct 26 06:36:58 volumio volumio[680]:   errno: -110,
Oct 26 06:36:58 volumio volumio[680]:   code: 'ETIMEDOUT',
Oct 26 06:36:58 volumio volumio[680]:   syscall: 'connect',
Oct 26 06:36:58 volumio volumio[680]:   address: '199.59.149.208',
Oct 26 06:36:58 volumio volumio[680]:   port: 443
Oct 26 06:36:58 volumio volumio[680]: }
Oct 26 06:36:58 volumio volumio[680]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 26 06:36:58 volumio sudo[2100]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-26 06:35
Oct 26 06:36:58 volumio sudo[2100]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939"
VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463"
VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7"
VOLUMIO_BE_VERSION="85acf7bbbceb3e3dec447156a39a88033f921210"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 30 Sep 2022 11:12:31 AM CEST"
VOLUMIO_VERSION="3.378"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="4d8af4ba9bde4fed178dd6b058b1d778"