-- Logs begin at Sat 2024-10-12 14:02:34 UTC, end at Fri 2025-01-17 11:28:00 UTC. -- Jan 17 11:27:01 volumio volumio[4632]: info: Jan 17 11:27:01 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:01 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:01 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:01 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 17 11:27:01 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:01 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:01 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:01 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:01 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:01 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:01 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:01 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:01 volumio volumio[4632]: info: CorePlayQueue::getTrack 1 Jan 17 11:27:01 volumio volumio[4632]: 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://m701.music.126.net/20250117195158/d8487baa41d245c0d685cc31f142125c/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/31749762287/4458/7c6d/1cae/19f255ed816baf64ae24600c33165e03.m4a?vuutv=CFE7u8b76Yx5NrtEXTyKQKaYDqn9fPNtL1a3VJE+SbE/D6PR5pkQ8o0eeh0++jx9BAJKlna3edCFtkyv/nJHZuHzcZInjXMI97Lea9m9yxo=","trackType":""} Jan 17 11:27:01 volumio volumio[4632]: verbose: CURRENT POSITION 1 Jan 17 11:27:01 volumio volumio[4632]: info: CoreStateMachine::syncState stateService stop Jan 17 11:27:01 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:01 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:01 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:01 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:01 volumio volumio[4632]: info: No code Jan 17 11:27:01 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:01 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:01 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:01 volumio volumio[4632]: info: ------------------------------ 33ms Jan 17 11:27:01 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:01 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:01 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:01 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:01 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:01 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:01 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:01 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:01 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:07 volumio volumio[4632]: info: Clearing queue after UPNP request Jan 17 11:27:08 volumio volumio[4632]: info: CoreStateMachine::ClearQueue Jan 17 11:27:08 volumio volumio[4632]: info: CoreStateMachine::stop Jan 17 11:27:08 volumio volumio[4632]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 17 11:27:08 volumio volumio[4632]: UNSET VOLATILE Jan 17 11:27:08 volumio volumio[4632]: info: CorePlayQueue::clearPlayQueue Jan 17 11:27:08 volumio volumio[4632]: info: CorePlayQueue::saveQueue Jan 17 11:27:08 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:08 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:08 volumio volumio[4632]: info: CoreCommandRouter::volumioPushQueue Jan 17 11:27:08 volumio volumio[4632]: info: Jan 17 11:27:08 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:08 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:08 volumio volumio[4632]: error: updateQueue error: null Jan 17 11:27:08 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:08 volumio volumio[4632]: info: Starting UPNP Playback Jan 17 11:27:08 volumio volumio[4632]: info: Preparing playback through UPNP Jan 17 11:27:08 volumio volumio[4632]: info: CoreCommandRouter::volumioGetState Jan 17 11:27:08 volumio volumio[4632]: info: CorePlayQueue::getTrack 1 Jan 17 11:27:08 volumio volumio[4632]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 17 11:27:08 volumio volumio[4632]: info: Jan 17 11:27:08 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:08 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:08 volumio volumio[4632]: info: ------------------------------ 11ms Jan 17 11:27:08 volumio volumio[4632]: info: Jan 17 11:27:08 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:08 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:08 volumio volumio[4632]: info: Jan 17 11:27:08 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:08 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:08 volumio volumio[4632]: info: ------------------------------ 4ms Jan 17 11:27:08 volumio volumio[4632]: info: ------------------------------ 3ms Jan 17 11:27:08 volumio volumio[4632]: info: Jan 17 11:27:08 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:08 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:08 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:08 volumio volumio[4632]: info: Jan 17 11:27:08 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:08 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:08 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:08 volumio volumio[4632]: info: Jan 17 11:27:08 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:08 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:08 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:09 volumio volumio[4632]: info: Jan 17 11:27:09 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:09 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:09 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:09 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 17 11:27:09 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:09 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:09 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:09 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:09 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:09 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:09 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:09 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:09 volumio volumio[4632]: info: CorePlayQueue::getTrack 1 Jan 17 11:27:09 volumio volumio[4632]: 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://m801.music.126.net/20250117195207/9b8c1ebcb6d1474894f93575604c1aa4/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/31749762287/4458/7c6d/1cae/19f255ed816baf64ae24600c33165e03.m4a?vuutv=RhbEIQlIqwZunX2BTIil5TW7T//bjhkFPTsO7upJep09CRvwiyT/Tx/UXPNaeMWJyWLbGhIRbq6jmxLWlCO+sqzVymRlflh7+jgC1sZ1ASM=","trackType":""} Jan 17 11:27:09 volumio volumio[4632]: verbose: CURRENT POSITION 1 Jan 17 11:27:09 volumio volumio[4632]: info: CoreStateMachine::syncState stateService stop Jan 17 11:27:09 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:09 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:09 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:09 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:09 volumio volumio[4632]: info: No code Jan 17 11:27:09 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:09 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:09 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:09 volumio volumio[4632]: info: ------------------------------ 41ms Jan 17 11:27:09 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:09 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:09 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:09 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:09 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:09 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:09 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:09 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:09 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:24 volumio volumio[4632]: info: Clearing queue after UPNP request Jan 17 11:27:24 volumio volumio[4632]: info: CoreStateMachine::ClearQueue Jan 17 11:27:24 volumio volumio[4632]: info: CoreStateMachine::stop Jan 17 11:27:24 volumio volumio[4632]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 17 11:27:24 volumio volumio[4632]: UNSET VOLATILE Jan 17 11:27:24 volumio volumio[4632]: info: CorePlayQueue::clearPlayQueue Jan 17 11:27:24 volumio volumio[4632]: info: CorePlayQueue::saveQueue Jan 17 11:27:24 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:24 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:24 volumio volumio[4632]: info: CoreCommandRouter::volumioPushQueue Jan 17 11:27:24 volumio volumio[4632]: info: Jan 17 11:27:24 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:24 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:24 volumio volumio[4632]: error: updateQueue error: null Jan 17 11:27:24 volumio volumio[4632]: info: ------------------------------ 3ms Jan 17 11:27:24 volumio volumio[4632]: info: Starting UPNP Playback Jan 17 11:27:24 volumio volumio[4632]: info: Preparing playback through UPNP Jan 17 11:27:24 volumio volumio[4632]: info: CoreCommandRouter::volumioGetState Jan 17 11:27:24 volumio volumio[4632]: info: CorePlayQueue::getTrack 1 Jan 17 11:27:24 volumio volumio[4632]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 17 11:27:25 volumio volumio[4632]: info: Jan 17 11:27:25 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:25 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:25 volumio volumio[4632]: info: Jan 17 11:27:25 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:25 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:25 volumio volumio[4632]: info: ------------------------------ 3ms Jan 17 11:27:25 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:25 volumio volumio[4632]: info: Jan 17 11:27:25 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:25 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:25 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:25 volumio volumio[4632]: info: Jan 17 11:27:25 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:25 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:25 volumio volumio[4632]: info: ------------------------------ 10ms Jan 17 11:27:25 volumio volumio[4632]: info: Jan 17 11:27:25 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:25 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:25 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:25 volumio volumio[4632]: info: Jan 17 11:27:25 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:25 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:25 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:26 volumio volumio[4632]: info: Jan 17 11:27:26 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:26 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:26 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:26 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:26 volumio kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! Jan 17 11:27:26 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:26 volumio volumio[4632]: info: Jan 17 11:27:26 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:26 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:26 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:26 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:26 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:26 volumio volumio[4632]: In UPNP mode Jan 17 11:27:26 volumio volumio[4632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1074,"samplerate":"8 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"Hunter","artist":"Dido","album":"One Step Too Far","uri":"http://m7.music.126.net/20250117195224/5f0b537cab7837403100e621f0a37117/yyaac/obj/wonDkMOGw6XDiTHCmMOi/4119029682/c73e/733b/a968/b1fb84b8966486565bc88d6ddf703bcf.m4a?vuutv=ibt7G1BvUY64dJTKFQeA6dNbiPcUeJ4TvIwmwMGCPLT/+p8D9spwbJzdrw+uuOxwbmkj7zp7QVVouibx+3Yd51b+4CCTuzTkW5aWUv1+QBU=","trackType":""} Jan 17 11:27:26 volumio volumio[4632]: verbose: CURRENT POSITION 1 Jan 17 11:27:26 volumio volumio[4632]: info: CoreStateMachine::syncState stateService play Jan 17 11:27:26 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:26 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:26 volumio volumio[4632]: info: ------------------------------ 30ms Jan 17 11:27:26 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:26 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:26 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:26 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:26 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:26 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:26 volumio volumio[4632]: In UPNP mode Jan 17 11:27:26 volumio volumio[4632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":512,"duration":1074,"samplerate":"8 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"732 Kbps","isStreaming":false,"title":"Hunter","artist":"Dido","album":"One Step Too Far","uri":"http://m7.music.126.net/20250117195224/5f0b537cab7837403100e621f0a37117/yyaac/obj/wonDkMOGw6XDiTHCmMOi/4119029682/c73e/733b/a968/b1fb84b8966486565bc88d6ddf703bcf.m4a?vuutv=ibt7G1BvUY64dJTKFQeA6dNbiPcUeJ4TvIwmwMGCPLT/+p8D9spwbJzdrw+uuOxwbmkj7zp7QVVouibx+3Yd51b+4CCTuzTkW5aWUv1+QBU=","trackType":""} Jan 17 11:27:26 volumio volumio[4632]: verbose: CURRENT POSITION 1 Jan 17 11:27:26 volumio volumio[4632]: info: CoreStateMachine::syncState stateService play Jan 17 11:27:26 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus play Jan 17 11:27:26 volumio volumio[4632]: info: Received an update from plugin. extracting info from payload Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 17 11:27:26 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:26 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:26 volumio volumio[4632]: info: ------------------------------ 50ms Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:26 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:26 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:26 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:26 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:26 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:28 volumio volumio[4632]: info: Jan 17 11:27:28 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:28 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:28 volumio volumio[4632]: info: Jan 17 11:27:28 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:28 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:28 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:28 volumio volumio[4632]: error: updateQueue error: null Jan 17 11:27:28 volumio volumio[4632]: info: ------------------------------ 5ms Jan 17 11:27:28 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:28 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:28 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:28 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:28 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:28 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:28 volumio volumio[4632]: info: CorePlayQueue::getTrack 1 Jan 17 11:27:28 volumio volumio[4632]: 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} Jan 17 11:27:28 volumio volumio[4632]: verbose: CURRENT POSITION 1 Jan 17 11:27:28 volumio volumio[4632]: info: CoreStateMachine::syncState stateService stop Jan 17 11:27:28 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus play Jan 17 11:27:28 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:28 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:28 volumio volumio[4632]: info: CoreStateMachine::stPlaybackTimer Jan 17 11:27:28 volumio volumio[4632]: info: ------------------------------ 22ms Jan 17 11:27:28 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:28 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:28 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:30 volumio kernel: usb 1-1.3: USB disconnect, device number 5 Jan 17 11:27:30 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Jan 17 11:27:30 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Jan 17 11:27:30 volumio udisks-glue[628]: Device file /dev/sda1 unmounted from /media/0DCA11CA0DCA11CA Jan 17 11:27:30 volumio udisks-glue[628]: Device file /dev/sda1 removed Jan 17 11:27:30 volumio udisks-glue[628]: Device file /dev/sda removed Jan 17 11:27:30 volumio udisks-glue[628]: Updating DB (#6) ... Jan 17 11:27:30 volumio udisks-glue[628]: volume: 40% repeat: off random: off single: off consume: on Jan 17 11:27:30 volumio udisks-glue[628]: Updating DB (#6) ... Jan 17 11:27:30 volumio udisks-glue[628]: volume: 40% repeat: off random: off single: off consume: on Jan 17 11:27:30 volumio ntfs-3g[2282]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Jan 17 11:27:30 volumio ntfs-3g[2282]: Failed to read vcn 0x0: Input/output error Jan 17 11:27:30 volumio ntfs-3g[2282]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Jan 17 11:27:30 volumio ntfs-3g[2282]: Failed to read vcn 0x0: Input/output error Jan 17 11:27:30 volumio kernel: Buffer I/O error on dev sda1, logical block 395879880, async page read Jan 17 11:27:30 volumio kernel: Buffer I/O error on dev sda1, logical block 395879880, async page read Jan 17 11:27:30 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:30 volumio volumio[4632]: info: Jan 17 11:27:30 volumio volumio[4632]: ---------------------------- MPD announces state update: update Jan 17 11:27:30 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:30 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:30 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:30 volumio ntfs-3g[2282]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Jan 17 11:27:30 volumio ntfs-3g[2282]: Failed to read vcn 0x0: Input/output error Jan 17 11:27:30 volumio ntfs-3g[2282]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Jan 17 11:27:30 volumio ntfs-3g[2282]: Failed to read vcn 0x0: Input/output error Jan 17 11:27:30 volumio ntfs-3g[2282]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Jan 17 11:27:30 volumio ntfs-3g[2282]: Failed to read vcn 0x0: Input/output error Jan 17 11:27:30 volumio kernel: Buffer I/O error on dev sda1, logical block 395879880, async page read Jan 17 11:27:30 volumio kernel: Buffer I/O error on dev sda1, logical block 395879880, async page read Jan 17 11:27:30 volumio kernel: Buffer I/O error on dev sda1, logical block 395879880, async page read Jan 17 11:27:30 volumio ntfs-3g[2282]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Jan 17 11:27:30 volumio ntfs-3g[2282]: Failed to read vcn 0x0: Input/output error Jan 17 11:27:31 volumio kernel: Buffer I/O error on dev sda1, logical block 395879880, async page read Jan 17 11:27:31 volumio ntfs-3g[2282]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Jan 17 11:27:31 volumio ntfs-3g[2282]: Failed to read index block: Input/output error Jan 17 11:27:31 volumio ntfs-3g[2282]: Unmounting /dev/sda1 () Jan 17 11:27:31 volumio kernel: Buffer I/O error on dev sda1, logical block 395879880, async page read Jan 17 11:27:32 volumio ntfs-3g[2282]: Failed to sync device /dev/sda1: Input/output error Jan 17 11:27:32 volumio ntfs-3g[2282]: Failed to close volume /dev/sda1: Input/output error Jan 17 11:27:32 volumio volumio[4632]: info: Command Router : Notfying DB Updatetrue Jan 17 11:27:32 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:32 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:32 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:32 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:32 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:32 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:32 volumio volumio[4632]: info: CorePlayQueue::getTrack 0 Jan 17 11:27:32 volumio volumio[4632]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 17 11:27:32 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:32 volumio volumio[4632]: info: CoreStateMachine::syncState stateService stop Jan 17 11:27:32 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:32 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:32 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:32 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:32 volumio volumio[4632]: info: No code Jan 17 11:27:32 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:32 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:32 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:32 volumio volumio[4632]: info: ------------------------------ 1934ms Jan 17 11:27:32 volumio volumio[4632]: info: MPD Database updated - AlbumList cache refreshed Jan 17 11:27:32 volumio volumio[4632]: info: Jan 17 11:27:32 volumio volumio[4632]: ---------------------------- MPD announces state update: database Jan 17 11:27:32 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:32 volumio volumio[4632]: info: Jan 17 11:27:32 volumio volumio[4632]: ---------------------------- MPD announces state update: update Jan 17 11:27:32 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:32 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:32 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:32 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:32 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:32 volumio volumio[4632]: info: Jan 17 11:27:32 volumio volumio[4632]: ---------------------------- MPD announces state update: update Jan 17 11:27:32 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:32 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:32 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:32 volumio volumio[4632]: info: Command Router : Notfying DB Updatefalse Jan 17 11:27:32 volumio volumio[4632]: info: CoreCommandRouter::Close All Modals sent Jan 17 11:27:32 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:32 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:32 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:32 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:33 volumio volumio[4632]: info: CorePlayQueue::getTrack 0 Jan 17 11:27:33 volumio volumio[4632]: 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} Jan 17 11:27:33 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::syncState stateService stop Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:33 volumio volumio[4632]: info: No code Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:33 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:33 volumio volumio[4632]: info: CorePlayQueue::getTrack 0 Jan 17 11:27:33 volumio volumio[4632]: 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} Jan 17 11:27:33 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::syncState stateService stop Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:33 volumio volumio[4632]: info: No code Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:33 volumio volumio[4632]: info: ------------------------------ 131ms Jan 17 11:27:33 volumio volumio[4632]: info: ------------------------------ 132ms Jan 17 11:27:33 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:33 volumio volumio[4632]: info: Command Router : Notfying DB Updatefalse Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::Close All Modals sent Jan 17 11:27:33 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:33 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:33 volumio volumio[4632]: info: CorePlayQueue::getTrack 0 Jan 17 11:27:33 volumio volumio[4632]: 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} Jan 17 11:27:33 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::syncState stateService stop Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:33 volumio volumio[4632]: info: No code Jan 17 11:27:33 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:33 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:33 volumio volumio[4632]: info: ------------------------------ 180ms Jan 17 11:27:33 volumio volumio[4632]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dido/One%20Step%20Too%20Far/108aa4c2-960a-436a-a98c-8879bee814a7.png' Jan 17 11:27:33 volumio volumio[4632]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dido/One%20Step%20Too%20Far/108aa4c2-960a-436a-a98c-8879bee814a7.png' Jan 17 11:27:34 volumio volumio[4632]: info: Clearing queue after UPNP request Jan 17 11:27:34 volumio volumio[4632]: info: CoreStateMachine::ClearQueue Jan 17 11:27:34 volumio volumio[4632]: info: CoreStateMachine::stop Jan 17 11:27:34 volumio volumio[4632]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 17 11:27:34 volumio volumio[4632]: UNSET VOLATILE Jan 17 11:27:34 volumio volumio[4632]: info: CorePlayQueue::clearPlayQueue Jan 17 11:27:34 volumio volumio[4632]: info: CorePlayQueue::saveQueue Jan 17 11:27:34 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:34 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:34 volumio volumio[4632]: info: CoreCommandRouter::volumioPushQueue Jan 17 11:27:34 volumio volumio[4632]: info: Jan 17 11:27:34 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:34 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:34 volumio volumio[4632]: error: updateQueue error: null Jan 17 11:27:34 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:34 volumio volumio[4632]: info: Starting UPNP Playback Jan 17 11:27:34 volumio volumio[4632]: info: Preparing playback through UPNP Jan 17 11:27:34 volumio volumio[4632]: info: CoreCommandRouter::volumioGetState Jan 17 11:27:34 volumio volumio[4632]: info: CorePlayQueue::getTrack 0 Jan 17 11:27:34 volumio volumio[4632]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 17 11:27:35 volumio volumio[4632]: info: Jan 17 11:27:35 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:35 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:35 volumio volumio[4632]: info: ------------------------------ 1ms Jan 17 11:27:35 volumio volumio[4632]: info: Jan 17 11:27:35 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:35 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:35 volumio volumio[4632]: info: Jan 17 11:27:35 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:35 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:35 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:35 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:35 volumio volumio[4632]: info: Jan 17 11:27:35 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:35 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:35 volumio volumio[4632]: info: Jan 17 11:27:35 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:35 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:35 volumio volumio[4632]: info: ------------------------------ 3ms Jan 17 11:27:35 volumio volumio[4632]: info: ------------------------------ 3ms Jan 17 11:27:35 volumio volumio[4632]: info: Jan 17 11:27:35 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:35 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:35 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:36 volumio volumio[4632]: info: Jan 17 11:27:36 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:36 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:36 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:36 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:36 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:36 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:36 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:36 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:36 volumio volumio[4632]: In UPNP mode Jan 17 11:27:36 volumio volumio[4632]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hunter","artist":"Dido","album":"One Step Too Far","uri":"http://m7.music.126.net/20250117195224/5f0b537cab7837403100e621f0a37117/yyaac/obj/wonDkMOGw6XDiTHCmMOi/4119029682/c73e/733b/a968/b1fb84b8966486565bc88d6ddf703bcf.m4a?vuutv=ibt7G1BvUY64dJTKFQeA6dNbiPcUeJ4TvIwmwMGCPLT/+p8D9spwbJzdrw+uuOxwbmkj7zp7QVVouibx+3Yd51b+4CCTuzTkW5aWUv1+QBU=","trackType":""} Jan 17 11:27:36 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:36 volumio volumio[4632]: info: CoreStateMachine::syncState stateService pause Jan 17 11:27:36 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:36 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:36 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:36 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:36 volumio volumio[4632]: info: ------------------------------ 29ms Jan 17 11:27:36 volumio volumio[4632]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dido/One%20Step%20Too%20Far/108aa4c2-960a-436a-a98c-8879bee814a7.png' Jan 17 11:27:36 volumio volumio[4632]: info: Jan 17 11:27:36 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:36 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:36 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:36 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 17 11:27:36 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:36 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:36 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:36 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:36 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:36 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:36 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:36 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:36 volumio volumio[4632]: info: CorePlayQueue::getTrack 0 Jan 17 11:27:36 volumio volumio[4632]: 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":"Hunter","artist":"Dido","album":"One Step Too Far","uri":"http://m7.music.126.net/20250117195224/5f0b537cab7837403100e621f0a37117/yyaac/obj/wonDkMOGw6XDiTHCmMOi/4119029682/c73e/733b/a968/b1fb84b8966486565bc88d6ddf703bcf.m4a?vuutv=ibt7G1BvUY64dJTKFQeA6dNbiPcUeJ4TvIwmwMGCPLT/+p8D9spwbJzdrw+uuOxwbmkj7zp7QVVouibx+3Yd51b+4CCTuzTkW5aWUv1+QBU=","trackType":""} Jan 17 11:27:36 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:36 volumio volumio[4632]: info: CoreStateMachine::syncState stateService stop Jan 17 11:27:36 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:36 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:36 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:36 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:36 volumio volumio[4632]: info: No code Jan 17 11:27:36 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:36 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:36 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:36 volumio volumio[4632]: info: ------------------------------ 31ms Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:37 volumio volumio[4632]: info: Jan 17 11:27:37 volumio volumio[4632]: ---------------------------- MPD announces state update: update Jan 17 11:27:37 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:37 volumio volumio[4632]: info: Jan 17 11:27:37 volumio volumio[4632]: ---------------------------- MPD announces state update: update Jan 17 11:27:37 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:37 volumio volumio[4632]: info: Command Router : Notfying DB Updatefalse Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::Close All Modals sent Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:37 volumio volumio[4632]: info: Command Router : Notfying DB Updatefalse Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::Close All Modals sent Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:37 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:37 volumio volumio[4632]: info: CorePlayQueue::getTrack 0 Jan 17 11:27:37 volumio volumio[4632]: 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":"Hunter","artist":"Dido","album":"One Step Too Far","uri":"http://m7.music.126.net/20250117195224/5f0b537cab7837403100e621f0a37117/yyaac/obj/wonDkMOGw6XDiTHCmMOi/4119029682/c73e/733b/a968/b1fb84b8966486565bc88d6ddf703bcf.m4a?vuutv=ibt7G1BvUY64dJTKFQeA6dNbiPcUeJ4TvIwmwMGCPLT/+p8D9spwbJzdrw+uuOxwbmkj7zp7QVVouibx+3Yd51b+4CCTuzTkW5aWUv1+QBU=","trackType":""} Jan 17 11:27:37 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:37 volumio volumio[4632]: info: CoreStateMachine::syncState stateService stop Jan 17 11:27:37 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:37 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:37 volumio volumio[4632]: info: No code Jan 17 11:27:37 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:37 volumio volumio[4632]: info: ------------------------------ 131ms Jan 17 11:27:37 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:37 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:37 volumio volumio[4632]: info: CorePlayQueue::getTrack 0 Jan 17 11:27:37 volumio volumio[4632]: 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":"Hunter","artist":"Dido","album":"One Step Too Far","uri":"http://m7.music.126.net/20250117195224/5f0b537cab7837403100e621f0a37117/yyaac/obj/wonDkMOGw6XDiTHCmMOi/4119029682/c73e/733b/a968/b1fb84b8966486565bc88d6ddf703bcf.m4a?vuutv=ibt7G1BvUY64dJTKFQeA6dNbiPcUeJ4TvIwmwMGCPLT/+p8D9spwbJzdrw+uuOxwbmkj7zp7QVVouibx+3Yd51b+4CCTuzTkW5aWUv1+QBU=","trackType":""} Jan 17 11:27:37 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:37 volumio volumio[4632]: info: CoreStateMachine::syncState stateService stop Jan 17 11:27:37 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:37 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:37 volumio volumio[4632]: info: No code Jan 17 11:27:37 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:37 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:37 volumio volumio[4632]: info: ------------------------------ 161ms Jan 17 11:27:38 volumio volumio[4632]: info: Jan 17 11:27:38 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:38 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:38 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:38 volumio kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! Jan 17 11:27:38 volumio volumio[4632]: info: Jan 17 11:27:38 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:38 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:38 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:38 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:38 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:38 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:38 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:38 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:38 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:38 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:38 volumio volumio[4632]: In UPNP mode Jan 17 11:27:38 volumio volumio[4632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":429,"samplerate":"11.025 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"Hunter","artist":"Dido","album":"One Step Too Far","uri":"http://m7.music.126.net/20250117195224/5f0b537cab7837403100e621f0a37117/yyaac/obj/wonDkMOGw6XDiTHCmMOi/4119029682/c73e/733b/a968/b1fb84b8966486565bc88d6ddf703bcf.m4a?vuutv=ibt7G1BvUY64dJTKFQeA6dNbiPcUeJ4TvIwmwMGCPLT/+p8D9spwbJzdrw+uuOxwbmkj7zp7QVVouibx+3Yd51b+4CCTuzTkW5aWUv1+QBU=","trackType":""} Jan 17 11:27:38 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:38 volumio volumio[4632]: info: CoreStateMachine::syncState stateService play Jan 17 11:27:38 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:38 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:38 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:38 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:38 volumio volumio[4632]: info: ------------------------------ 22ms Jan 17 11:27:38 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:38 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:38 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:38 volumio volumio[4632]: In UPNP mode Jan 17 11:27:38 volumio volumio[4632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":185,"duration":429,"samplerate":"11.025 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"Hunter","artist":"Dido","album":"One Step Too Far","uri":"http://m7.music.126.net/20250117195224/5f0b537cab7837403100e621f0a37117/yyaac/obj/wonDkMOGw6XDiTHCmMOi/4119029682/c73e/733b/a968/b1fb84b8966486565bc88d6ddf703bcf.m4a?vuutv=ibt7G1BvUY64dJTKFQeA6dNbiPcUeJ4TvIwmwMGCPLT/+p8D9spwbJzdrw+uuOxwbmkj7zp7QVVouibx+3Yd51b+4CCTuzTkW5aWUv1+QBU=","trackType":""} Jan 17 11:27:38 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:38 volumio volumio[4632]: info: CoreStateMachine::syncState stateService play Jan 17 11:27:38 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus play Jan 17 11:27:38 volumio volumio[4632]: info: Received an update from plugin. extracting info from payload Jan 17 11:27:38 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 17 11:27:38 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:38 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:38 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:38 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:38 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:38 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:38 volumio volumio[4632]: info: ------------------------------ 32ms Jan 17 11:27:38 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:38 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:38 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:38 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:38 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:38 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:40 volumio volumio[4632]: info: Jan 17 11:27:40 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:40 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:40 volumio volumio[4632]: info: Jan 17 11:27:40 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:40 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:40 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:40 volumio volumio[4632]: error: updateQueue error: null Jan 17 11:27:40 volumio volumio[4632]: info: ------------------------------ 6ms Jan 17 11:27:40 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:40 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:40 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:40 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:40 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:40 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:40 volumio volumio[4632]: info: CorePlayQueue::getTrack 0 Jan 17 11:27:40 volumio volumio[4632]: 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} Jan 17 11:27:40 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:40 volumio volumio[4632]: info: CoreStateMachine::syncState stateService stop Jan 17 11:27:40 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus play Jan 17 11:27:40 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:40 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:40 volumio volumio[4632]: info: CoreStateMachine::stPlaybackTimer Jan 17 11:27:40 volumio volumio[4632]: info: ------------------------------ 26ms Jan 17 11:27:40 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:40 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:40 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:43 volumio volumio[4632]: info: Clearing queue after UPNP request Jan 17 11:27:43 volumio volumio[4632]: info: CoreStateMachine::ClearQueue Jan 17 11:27:43 volumio volumio[4632]: info: CoreStateMachine::stop Jan 17 11:27:43 volumio volumio[4632]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 17 11:27:43 volumio volumio[4632]: UNSET VOLATILE Jan 17 11:27:43 volumio volumio[4632]: info: CorePlayQueue::clearPlayQueue Jan 17 11:27:43 volumio volumio[4632]: info: CorePlayQueue::saveQueue Jan 17 11:27:43 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:43 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:43 volumio volumio[4632]: info: CoreCommandRouter::volumioPushQueue Jan 17 11:27:43 volumio volumio[4632]: info: Jan 17 11:27:43 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:43 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:43 volumio volumio[4632]: error: updateQueue error: null Jan 17 11:27:43 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:43 volumio volumio[4632]: info: Starting UPNP Playback Jan 17 11:27:43 volumio volumio[4632]: info: Preparing playback through UPNP Jan 17 11:27:43 volumio volumio[4632]: info: CoreCommandRouter::volumioGetState Jan 17 11:27:43 volumio volumio[4632]: info: CorePlayQueue::getTrack 0 Jan 17 11:27:43 volumio volumio[4632]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 17 11:27:44 volumio volumio[4632]: info: Jan 17 11:27:44 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:44 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:44 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:44 volumio volumio[4632]: info: Jan 17 11:27:44 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:44 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:44 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:44 volumio volumio[4632]: info: Jan 17 11:27:44 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:44 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:44 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:44 volumio volumio[4632]: info: Jan 17 11:27:44 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:44 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:44 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:44 volumio volumio[4632]: info: Jan 17 11:27:44 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:44 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:44 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:44 volumio volumio[4632]: info: Jan 17 11:27:44 volumio volumio[4632]: ---------------------------- MPD announces system playlist update Jan 17 11:27:44 volumio volumio[4632]: info: Ignoring MPD Status Update Jan 17 11:27:44 volumio volumio[4632]: info: ------------------------------ 2ms Jan 17 11:27:44 volumio volumio[4632]: info: Jan 17 11:27:44 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:44 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:44 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:44 volumio volumio[4632]: info: Jan 17 11:27:44 volumio volumio[4632]: ---------------------------- MPD announces state update: player Jan 17 11:27:44 volumio volumio[4632]: info: ControllerMpd::getState Jan 17 11:27:44 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:27:44 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:44 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:44 volumio volumio[4632]: verbose: ControllerMpd::parseState Jan 17 11:27:44 volumio volumio[4632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:27:44 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:44 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:44 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:44 volumio volumio[4632]: In UPNP mode Jan 17 11:27:44 volumio volumio[4632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":174,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"空山新雨后","artist":"音阙诗听/锦零","album":"听","uri":"http://m7.music.126.net/20250117195243/78f562276c2c4402306a7ef27427be1d/ymusic/0f5c/020b/5152/8686e32b9f5a2f62d166f8cedcb4b462.mp3?vuutv=RXCyVx8SwIBMN17vMi/Sqngbbf3mnUM0xr6nefHHGHx11erJIiKkJGKzh6wh7qO7NEvqh1Sq/ZeDKOQJ371Y/uViOWkbUKAvL4FYi9D+01k=","trackType":""} Jan 17 11:27:44 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:44 volumio volumio[4632]: info: CoreStateMachine::syncState stateService play Jan 17 11:27:44 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:27:44 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:44 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:44 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:44 volumio volumio[4632]: info: ------------------------------ 28ms Jan 17 11:27:44 volumio volumio[4632]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:27:44 volumio volumio[4632]: info: ControllerMpd::pushState Jan 17 11:27:44 volumio volumio[4632]: info: CoreCommandRouter::servicePushState Jan 17 11:27:44 volumio volumio[4632]: In UPNP mode Jan 17 11:27:44 volumio volumio[4632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":174,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"空山新雨后","artist":"音阙诗听/锦零","album":"听","uri":"http://m7.music.126.net/20250117195243/78f562276c2c4402306a7ef27427be1d/ymusic/0f5c/020b/5152/8686e32b9f5a2f62d166f8cedcb4b462.mp3?vuutv=RXCyVx8SwIBMN17vMi/Sqngbbf3mnUM0xr6nefHHGHx11erJIiKkJGKzh6wh7qO7NEvqh1Sq/ZeDKOQJ371Y/uViOWkbUKAvL4FYi9D+01k=","trackType":""} Jan 17 11:27:44 volumio volumio[4632]: verbose: CURRENT POSITION 0 Jan 17 11:27:44 volumio volumio[4632]: info: CoreStateMachine::syncState stateService play Jan 17 11:27:44 volumio volumio[4632]: info: CoreStateMachine::syncState currentStatus play Jan 17 11:27:44 volumio volumio[4632]: info: Received an update from plugin. extracting info from payload Jan 17 11:27:44 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 17 11:27:44 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:44 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:44 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:44 volumio volumio[4632]: info: CoreStateMachine::pushState Jan 17 11:27:44 volumio volumio[4632]: info: CoreCommandRouter::volumioPushState Jan 17 11:27:44 volumio volumio[4632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:27:44 volumio volumio[4632]: info: ------------------------------ 40ms Jan 17 11:27:44 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:44 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:44 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:44 volumio volumio[4632]: info: CoreCommandRouter::volumioGetQueue Jan 17 11:27:44 volumio volumio[4632]: info: CoreStateMachine::getQueue Jan 17 11:27:44 volumio volumio[4632]: info: CorePlayQueue::getQueue Jan 17 11:27:44 volumio volumio[4632]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dido/One%20Step%20Too%20Far/108aa4c2-960a-436a-a98c-8879bee814a7.png' Jan 17 11:27:59 volumio volumio[4632]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 11:27:59 volumio volumio[4632]: { Error: connect ETIMEDOUT 69.171.229.73:443 Jan 17 11:27:59 volumio volumio[4632]: at Object._errnoException (util.js:1022:11) Jan 17 11:27:59 volumio volumio[4632]: at _exceptionWithHostPort (util.js:1044:20) Jan 17 11:27:59 volumio volumio[4632]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 17 11:27:59 volumio volumio[4632]: code: 'ETIMEDOUT', Jan 17 11:27:59 volumio volumio[4632]: errno: 'ETIMEDOUT', Jan 17 11:27:59 volumio volumio[4632]: syscall: 'connect', Jan 17 11:27:59 volumio volumio[4632]: address: '69.171.229.73', Jan 17 11:27:59 volumio volumio[4632]: port: 443 } Jan 17 11:27:59 volumio volumio[4632]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 11:28:00 volumio sudo[8130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 11:27 Jan 17 11:28:00 volumio sudo[8130]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"