-- Logs begin at Mon 2025-01-13 11:21:21 UTC, end at Mon 2025-01-13 11:39:57 UTC. -- Jan 13 11:38:00 volumio volumio-streaming-daemon[1879]: Environment: production Jan 13 11:38:00 volumio volumio[930]: info: Fetching Streaming Services browse cache Jan 13 11:38:18 volumio kernel: usb 1-1.2: new high-speed USB device number 5 using ehci-pci Jan 13 11:38:18 volumio kernel: usb 1-1.2: New USB device found, idVendor=048d, idProduct=1234 Jan 13 11:38:18 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 13 11:38:18 volumio kernel: usb 1-1.2: Product: UDisk Jan 13 11:38:18 volumio kernel: usb 1-1.2: Manufacturer: General Jan 13 11:38:18 volumio kernel: usb 1-1.2: SerialNumber: 0901012110317532537900 Jan 13 11:38:18 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Jan 13 11:38:18 volumio kernel: scsi host6: usb-storage 1-1.2:1.0 Jan 13 11:38:19 volumio kernel: scsi 6:0:0:0: Direct-Access General UDisk 5.00 PQ: 0 ANSI: 2 Jan 13 11:38:19 volumio kernel: sd 6:0:0:0: Attached scsi generic sg2 type 0 Jan 13 11:38:19 volumio kernel: sd 6:0:0:0: [sdb] 1966080 512-byte logical blocks: (1.00 GB/960 MiB) Jan 13 11:38:19 volumio kernel: sd 6:0:0:0: [sdb] Write Protect is off Jan 13 11:38:19 volumio kernel: sd 6:0:0:0: [sdb] Mode Sense: 0b 00 00 08 Jan 13 11:38:19 volumio kernel: sd 6:0:0:0: [sdb] No Caching mode page found Jan 13 11:38:19 volumio kernel: sd 6:0:0:0: [sdb] Assuming drive cache: write through Jan 13 11:38:19 volumio kernel: sdb: sdb1 Jan 13 11:38:19 volumio kernel: sd 6:0:0:0: [sdb] Attached SCSI removable disk Jan 13 11:38:19 volumio udisks-glue[690]: Device file /dev/sdb inserted Jan 13 11:38:19 volumio udisks-glue[690]: Device file /dev/sdb1 inserted Jan 13 11:38:19 volumio udisks-glue[690]: Trying to automount /dev/sdb1... Jan 13 11:38:19 volumio kernel: FAT-fs (sdb1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jan 13 11:38:19 volumio udisks-glue[690]: Successfully automounted /dev/sdb1 at /media/FLASHDEVICE Jan 13 11:38:19 volumio udisks-glue[690]: Device file /dev/sdb1 mounted at /media/FLASHDEVICE Jan 13 11:38:19 volumio udisks-glue[690]: Updating DB (#2) ... Jan 13 11:38:19 volumio udisks-glue[690]: volume: n/a repeat: off random: off single: off consume: off Jan 13 11:38:19 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand status Jan 13 11:38:19 volumio volumio[930]: info: Jan 13 11:38:19 volumio volumio[930]: ---------------------------- MPD announces state update: update Jan 13 11:38:19 volumio volumio[930]: info: ControllerMpd::getState Jan 13 11:38:19 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand status Jan 13 11:38:19 volumio volumio[930]: info: sendMpdCommand status took 0 milliseconds Jan 13 11:38:19 volumio volumio[930]: info: sendMpdCommand status took 1 milliseconds Jan 13 11:38:19 volumio volumio[930]: verbose: ControllerMpd::parseState Jan 13 11:38:19 volumio volumio[930]: info: Command Router : Notfying DB Updatetrue Jan 13 11:38:19 volumio volumio[930]: verbose: ControllerMpd::parseState Jan 13 11:38:19 volumio volumio[930]: info: ControllerMpd::pushState Jan 13 11:38:19 volumio volumio[930]: info: CoreCommandRouter::servicePushState Jan 13 11:38:19 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:19 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:19 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:19 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:19 volumio volumio[930]: 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 13 11:38:19 volumio volumio[930]: verbose: CURRENT POSITION 0 Jan 13 11:38:19 volumio volumio[930]: info: CoreStateMachine::syncState stateService stop Jan 13 11:38:19 volumio volumio[930]: info: CoreStateMachine::syncState currentStatus stop Jan 13 11:38:19 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:19 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:19 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:19 volumio volumio[930]: info: No code Jan 13 11:38:19 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:19 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:19 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:19 volumio volumio[930]: info: ------------------------------ 143ms Jan 13 11:38:20 volumio volumio[930]: info: MPD Database updated - AlbumList cache refreshed Jan 13 11:38:20 volumio volumio[930]: info: Jan 13 11:38:20 volumio volumio[930]: ---------------------------- MPD announces state update: database Jan 13 11:38:20 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand status Jan 13 11:38:20 volumio volumio[930]: info: Jan 13 11:38:20 volumio volumio[930]: ---------------------------- MPD announces state update: update Jan 13 11:38:20 volumio volumio[930]: info: ControllerMpd::getState Jan 13 11:38:20 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand status Jan 13 11:38:20 volumio volumio[930]: info: ControllerMpd::getState Jan 13 11:38:20 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand status Jan 13 11:38:20 volumio volumio[930]: info: sendMpdCommand status took 1 milliseconds Jan 13 11:38:20 volumio volumio[930]: info: sendMpdCommand status took 1 milliseconds Jan 13 11:38:20 volumio volumio[930]: info: sendMpdCommand status took 1 milliseconds Jan 13 11:38:20 volumio volumio[930]: verbose: ControllerMpd::parseState Jan 13 11:38:20 volumio volumio[930]: info: Command Router : Notfying DB Updatefalse Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::Close All Modals sent Jan 13 11:38:20 volumio volumio[930]: verbose: ControllerMpd::parseState Jan 13 11:38:20 volumio volumio[930]: verbose: ControllerMpd::parseState Jan 13 11:38:20 volumio volumio[930]: info: ControllerMpd::pushState Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::servicePushState Jan 13 11:38:20 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:20 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:20 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:20 volumio volumio[930]: 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 13 11:38:20 volumio volumio[930]: verbose: CURRENT POSITION 0 Jan 13 11:38:20 volumio volumio[930]: info: CoreStateMachine::syncState stateService stop Jan 13 11:38:20 volumio volumio[930]: info: CoreStateMachine::syncState currentStatus stop Jan 13 11:38:20 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:20 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:20 volumio volumio[930]: info: No code Jan 13 11:38:20 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:20 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:20 volumio volumio[930]: info: ControllerMpd::pushState Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::servicePushState Jan 13 11:38:20 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:20 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:20 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:20 volumio volumio[930]: 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 13 11:38:20 volumio volumio[930]: verbose: CURRENT POSITION 0 Jan 13 11:38:20 volumio volumio[930]: info: CoreStateMachine::syncState stateService stop Jan 13 11:38:20 volumio volumio[930]: info: CoreStateMachine::syncState currentStatus stop Jan 13 11:38:20 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:20 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:20 volumio volumio[930]: info: No code Jan 13 11:38:20 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:20 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:20 volumio volumio[930]: info: ------------------------------ 45ms Jan 13 11:38:20 volumio volumio[930]: info: ------------------------------ 44ms Jan 13 11:38:24 volumio volumio[930]: info: CoreCommandRouter::volumioGetQueue Jan 13 11:38:24 volumio volumio[930]: info: CoreStateMachine::getQueue Jan 13 11:38:24 volumio volumio[930]: info: CorePlayQueue::getQueue Jan 13 11:38:30 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 13 11:38:35 volumio volumio[930]: info: CoreCommandRouter::volumioPlay Jan 13 11:38:35 volumio volumio[930]: verbose: UNSET VOLATILE Jan 13 11:38:35 volumio volumio[930]: info: CoreStateMachine::play index undefined Jan 13 11:38:35 volumio volumio[930]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 11:38:35 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:35 volumio volumio[930]: info: CoreStateMachine::startPlaybackTimer Jan 13 11:38:35 volumio volumio[930]: info: CorePlayQueue::getTrack 0 Jan 13 11:38:35 volumio volumio[930]: verbose: ControllerMpd::clearAddPlayTracks USB/FLASHDEVICE/罗刹海市 - 刀郎.flac Jan 13 11:38:35 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 11:38:35 volumio volumio[930]: info: sendMpdCommand stop took 2 milliseconds Jan 13 11:38:35 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand clear Jan 13 11:38:35 volumio volumio[930]: info: Jan 13 11:38:35 volumio volumio[930]: ---------------------------- MPD announces system playlist update Jan 13 11:38:35 volumio volumio[930]: info: Ignoring MPD Status Update Jan 13 11:38:35 volumio volumio[930]: info: sendMpdCommand clear took 0 milliseconds Jan 13 11:38:35 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand add "USB/FLASHDEVICE/罗刹海市 - 刀郎.flac" Jan 13 11:38:35 volumio volumio[930]: error: updateQueue error: null Jan 13 11:38:35 volumio volumio[930]: info: ------------------------------ 1ms Jan 13 11:38:39 volumio volumio[930]: info: CoreCommandRouter::volumioGetVisibleSources Jan 13 11:38:39 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 11:38:43 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 13 11:38:43 volumio volumio[930]: info: CURURI: music-library Jan 13 11:38:43 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 13 11:38:43 volumio volumio[930]: info: CURURI: music-library/USB Jan 13 11:38:45 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 13 11:38:45 volumio volumio[930]: info: CURURI: music-library/USB/FLASHDEVICE Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::ClearQueue Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::stop Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 11:38:50 volumio volumio[930]: verbose: UNSET VOLATILE Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::clearPlayQueue Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::saveQueue Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::volumioPushQueue Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::addQueueItems Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::addQueueItems Jan 13 11:38:50 volumio volumio[930]: info: Adding Item to queue: music-library/USB/FLASHDEVICE/03 - 被遺忘的時光(電影「無間道」插曲)-蔡琴.wav Jan 13 11:38:50 volumio volumio[930]: info: Exploding uri music-library/USB/FLASHDEVICE/03 - 被遺忘的時光(電影「無間道」插曲)-蔡琴.wav in service mpd Jan 13 11:38:50 volumio volumio[930]: info: Adding Item to queue: music-library/USB/FLASHDEVICE/45 - 千千阕歌-陈慧娴.wav Jan 13 11:38:50 volumio volumio[930]: info: Exploding uri music-library/USB/FLASHDEVICE/45 - 千千阕歌-陈慧娴.wav in service mpd Jan 13 11:38:50 volumio volumio[930]: info: Adding Item to queue: music-library/USB/FLASHDEVICE/晚风心里吹.wav Jan 13 11:38:50 volumio volumio[930]: info: Exploding uri music-library/USB/FLASHDEVICE/晚风心里吹.wav in service mpd Jan 13 11:38:50 volumio volumio[930]: info: Adding Item to queue: music-library/USB/FLASHDEVICE/花妖 - 刀郎.flac Jan 13 11:38:50 volumio volumio[930]: info: Exploding uri music-library/USB/FLASHDEVICE/花妖 - 刀郎.flac in service mpd Jan 13 11:38:50 volumio volumio[930]: info: Adding Item to queue: music-library/USB/FLASHDEVICE/颠倒歌 - 刀郎.flac Jan 13 11:38:50 volumio volumio[930]: info: Exploding uri music-library/USB/FLASHDEVICE/颠倒歌 - 刀郎.flac in service mpd Jan 13 11:38:50 volumio volumio[930]: info: Adding Item to queue: music-library/USB/FLASHDEVICE/01.岁岁--任素汐.flac Jan 13 11:38:50 volumio volumio[930]: info: Exploding uri music-library/USB/FLASHDEVICE/01.岁岁--任素汐.flac in service mpd Jan 13 11:38:50 volumio volumio[930]: info: Adding Item to queue: music-library/USB/FLASHDEVICE/最佳损友 （国语版）--任素汐.flac Jan 13 11:38:50 volumio volumio[930]: info: Exploding uri music-library/USB/FLASHDEVICE/最佳损友 （国语版）--任素汐.flac in service mpd Jan 13 11:38:50 volumio volumio[930]: info: ALBUMART /albumart?cacheid=297&web=//extralarge&path=%2Fmnt%2FUSB%2FFLASHDEVICE%2F03%20-%20%E8%A2%AB%E9%81%BA%E5%BF%98%E7%9A%84%E6%99%82%E5%85%89(%E9%9B%BB%E5%BD%B1%E3%80%8C%E7%84%A1%E9%96%93%E9%81%93%E3%80%8D%E6%8F%92%E6%9B%B2)-%E8%94%A1%E7%90%B4.wav&metadata=false Jan 13 11:38:50 volumio volumio[930]: info: URI /mnt/USB/FLASHDEVICE/03 - 被遺忘的時光(電影「無間道」插曲)-蔡琴.wav Jan 13 11:38:50 volumio volumio[930]: info: ALBUMART /albumart?cacheid=297&web=//extralarge&path=%2Fmnt%2FUSB%2FFLASHDEVICE%2F45%20-%20%E5%8D%83%E5%8D%83%E9%98%95%E6%AD%8C-%E9%99%88%E6%85%A7%E5%A8%B4.wav&metadata=false Jan 13 11:38:50 volumio volumio[930]: info: URI /mnt/USB/FLASHDEVICE/45 - 千千阕歌-陈慧娴.wav Jan 13 11:38:50 volumio volumio[930]: info: ALBUMART /albumart?cacheid=297&web=%3F%3F%3F//extralarge&path=%2Fmnt%2FUSB%2FFLASHDEVICE%2F%E6%99%9A%E9%A3%8E%E5%BF%83%E9%87%8C%E5%90%B9.wav&metadata=false Jan 13 11:38:50 volumio volumio[930]: info: URI /mnt/USB/FLASHDEVICE/晚风心里吹.wav Jan 13 11:38:50 volumio volumio[930]: info: ALBUMART /albumart?cacheid=297&web=%E5%88%80%E9%83%8E/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89/extralarge&path=%2Fmnt%2FUSB%2FFLASHDEVICE%2F%E8%8A%B1%E5%A6%96%20-%20%E5%88%80%E9%83%8E.flac&metadata=false Jan 13 11:38:50 volumio volumio[930]: info: URI /mnt/USB/FLASHDEVICE/花妖 - 刀郎.flac Jan 13 11:38:50 volumio volumio[930]: info: ALBUMART /albumart?cacheid=297&web=%E5%88%80%E9%83%8E/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89/extralarge&path=%2Fmnt%2FUSB%2FFLASHDEVICE%2F%E9%A2%A0%E5%80%92%E6%AD%8C%20-%20%E5%88%80%E9%83%8E.flac&metadata=false Jan 13 11:38:50 volumio volumio[930]: info: URI /mnt/USB/FLASHDEVICE/颠倒歌 - 刀郎.flac Jan 13 11:38:50 volumio volumio[930]: info: ALBUMART /albumart?cacheid=297&web=%E4%BB%BB%E7%B4%A0%E6%B1%90/%E5%B2%81%E5%B2%81/extralarge&path=%2Fmnt%2FUSB%2FFLASHDEVICE%2F01.%E5%B2%81%E5%B2%81--%E4%BB%BB%E7%B4%A0%E6%B1%90.flac&metadata=false Jan 13 11:38:50 volumio volumio[930]: info: URI /mnt/USB/FLASHDEVICE/01.岁岁--任素汐.flac Jan 13 11:38:50 volumio volumio[930]: info: ALBUMART /albumart?cacheid=297&web=%E4%BB%BB%E7%B4%A0%E6%B1%90/%E6%9C%80%E4%BD%B3%E6%8D%9F%E5%8F%8B%20%EF%BC%88%E5%9B%BD%E8%AF%AD%E7%89%88%EF%BC%89/extralarge&path=%2Fmnt%2FUSB%2FFLASHDEVICE%2F%E6%9C%80%E4%BD%B3%E6%8D%9F%E5%8F%8B%20%EF%BC%88%E5%9B%BD%E8%AF%AD%E7%89%88%EF%BC%89--%E4%BB%BB%E7%B4%A0%E6%B1%90.flac&metadata=false Jan 13 11:38:50 volumio volumio[930]: info: URI /mnt/USB/FLASHDEVICE/最佳损友 （国语版）--任素汐.flac Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::saveQueue Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::volumioPushQueue Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::updateTrackBlock Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::getTrackBlock Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::volumioPlay Jan 13 11:38:50 volumio volumio[930]: verbose: UNSET VOLATILE Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::play index 2 Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::stop Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 11:38:50 volumio volumio[930]: verbose: UNSET VOLATILE Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::play index undefined Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::getTrack 2 Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::startPlaybackTimer Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::getTrack 2 Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::clearAddPlayTracks USB/FLASHDEVICE/晚风心里吹.wav Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 11:38:50 volumio volumio[930]: info: sendMpdCommand stop took 1 milliseconds Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand clear Jan 13 11:38:50 volumio volumio[930]: info: Jan 13 11:38:50 volumio volumio[930]: ---------------------------- MPD announces system playlist update Jan 13 11:38:50 volumio volumio[930]: info: Ignoring MPD Status Update Jan 13 11:38:50 volumio volumio[930]: info: sendMpdCommand clear took 2 milliseconds Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand add "USB/FLASHDEVICE/晚风心里吹.wav" Jan 13 11:38:50 volumio volumio[930]: error: updateQueue error: null Jan 13 11:38:50 volumio volumio[930]: info: Jan 13 11:38:50 volumio volumio[930]: ---------------------------- MPD announces system playlist update Jan 13 11:38:50 volumio volumio[930]: info: Ignoring MPD Status Update Jan 13 11:38:50 volumio volumio[930]: info: ------------------------------ 1ms Jan 13 11:38:50 volumio volumio[930]: info: sendMpdCommand add "USB/FLASHDEVICE/晚风心里吹.wav" took 1 milliseconds Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand play Jan 13 11:38:50 volumio volumio[930]: info: ------------------------------ 4ms Jan 13 11:38:50 volumio volumio[930]: info: sendMpdCommand play took 4 milliseconds Jan 13 11:38:50 volumio volumio[930]: info: Jan 13 11:38:50 volumio volumio[930]: ---------------------------- MPD announces state update: player Jan 13 11:38:50 volumio volumio[930]: info: ControllerMpd::getState Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand status Jan 13 11:38:50 volumio volumio[930]: info: sendMpdCommand status took 14 milliseconds Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::parseState Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 11:38:50 volumio volumio[930]: info: Jan 13 11:38:50 volumio volumio[930]: ---------------------------- MPD announces state update: player Jan 13 11:38:50 volumio volumio[930]: info: ControllerMpd::getState Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand status Jan 13 11:38:50 volumio volumio[930]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::parseTrackInfo Jan 13 11:38:50 volumio volumio[930]: info: ControllerMpd::pushState Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::servicePushState Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::getTrack 2 Jan 13 11:38:50 volumio volumio[930]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"???","album":null,"uri":"USB/FLASHDEVICE/晚风心里吹.wav","trackType":"wav"} Jan 13 11:38:50 volumio volumio[930]: verbose: CURRENT POSITION 2 Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::syncState stateService play Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::syncState currentStatus stop Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::getTrack 2 Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:50 volumio volumio[930]: info: ------------------------------ 17ms Jan 13 11:38:50 volumio volumio[930]: info: sendMpdCommand status took 2 milliseconds Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::parseState Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 11:38:50 volumio volumio[930]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 13 11:38:50 volumio volumio[930]: verbose: ControllerMpd::parseTrackInfo Jan 13 11:38:50 volumio volumio[930]: info: ControllerMpd::pushState Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::servicePushState Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::getTrack 2 Jan 13 11:38:50 volumio volumio[930]: verbose: STATE SERVICE {"status":"play","position":0,"seek":160,"duration":184,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"???","album":null,"uri":"USB/FLASHDEVICE/晚风心里吹.wav","trackType":"wav"} Jan 13 11:38:50 volumio volumio[930]: verbose: CURRENT POSITION 2 Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::syncState stateService play Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::syncState currentStatus play Jan 13 11:38:50 volumio volumio[930]: info: Received an update from plugin. extracting info from payload Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::getTrack 2 Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:50 volumio volumio[930]: info: CoreStateMachine::pushState Jan 13 11:38:50 volumio volumio[930]: info: CorePlayQueue::getTrack 2 Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::volumioPushState Jan 13 11:38:50 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 11:38:50 volumio volumio[930]: info: ------------------------------ 7ms Jan 13 11:39:49 volumio volumio[930]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%88%80%E9%83%8E/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89/2d4140b0-f2ed-4bcb-b88e-d40522861714.jpg' Jan 13 11:39:56 volumio volumio[930]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 11:39:56 volumio volumio[930]: { Error: connect ETIMEDOUT 128.121.243.76:443 Jan 13 11:39:56 volumio volumio[930]: at Object._errnoException (util.js:1022:11) Jan 13 11:39:56 volumio volumio[930]: at _exceptionWithHostPort (util.js:1044:20) Jan 13 11:39:56 volumio volumio[930]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 13 11:39:56 volumio volumio[930]: code: 'ETIMEDOUT', Jan 13 11:39:56 volumio volumio[930]: errno: 'ETIMEDOUT', Jan 13 11:39:56 volumio volumio[930]: syscall: 'connect', Jan 13 11:39:56 volumio volumio[930]: address: '128.121.243.76', Jan 13 11:39:56 volumio volumio[930]: port: 443 } Jan 13 11:39:56 volumio volumio[930]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 11:39:57 volumio sudo[2218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-13 11:38 Jan 13 11:39:57 volumio sudo[2218]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"