-- Logs begin at Sat 2020-06-27 08:04:12 UTC, end at Thu 2026-08-27 12:17:41 UTC. -- Aug 27 12:16:02 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 12:16:02 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 12:16:02 smp volumio[1136]: info: Discovery: Getting this device information Aug 27 12:16:02 smp volumio[1136]: info: CoreCommandRouter::volumioGetState Aug 27 12:16:02 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:02 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 27 12:16:02 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 27 12:16:02 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 27 12:16:02 smp volumio[1136]: info: CoreCommandRouter::volumioGetState Aug 27 12:16:02 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:02 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 27 12:16:02 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 27 12:16:05 smp sudo[3716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 27 12:16:05 smp sudo[3716]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 12:16:05 smp sudo[3718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 12:16:05 smp sudo[3716]: pam_unix(sudo:session): session closed for user root Aug 27 12:16:05 smp sudo[3718]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 12:16:05 smp sudo[3718]: pam_unix(sudo:session): session closed for user root Aug 27 12:16:05 smp volumio[1136]: info: CoreCommandRouter::volumioGetState Aug 27 12:16:05 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:07 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 12:16:07 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 12:16:07 smp volumio[1136]: info: Discovery: Getting this device information Aug 27 12:16:07 smp volumio[1136]: info: CoreCommandRouter::volumioGetState Aug 27 12:16:07 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:07 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 27 12:16:07 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 27 12:16:07 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 27 12:16:07 smp volumio[1136]: info: CoreCommandRouter::volumioGetState Aug 27 12:16:07 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:07 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 27 12:16:07 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 27 12:16:16 smp volumio[1136]: info: CoreCommandRouter::volumioGetState Aug 27 12:16:16 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:16 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 27 12:16:16 smp volumio[1136]: info: Listing playlists Aug 27 12:16:16 smp volumio[1136]: info: CoreCommandRouter::volumioGetVisibleSources Aug 27 12:16:16 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 27 12:16:16 smp volumio[1136]: info: CoreCommandRouter::volumioGetQueue Aug 27 12:16:16 smp volumio[1136]: info: CoreStateMachine::getQueue Aug 27 12:16:16 smp volumio[1136]: info: CorePlayQueue::getQueue Aug 27 12:16:20 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 12:16:20 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 12:16:20 smp volumio[1136]: info: Discovery: Getting this device information Aug 27 12:16:20 smp volumio[1136]: info: CoreCommandRouter::volumioGetState Aug 27 12:16:20 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:20 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 27 12:16:20 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 27 12:16:20 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 27 12:16:23 smp volumio[1136]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 27 12:16:23 smp volumio[1136]: info: CoreStateMachine::ClearQueue Aug 27 12:16:23 smp volumio[1136]: info: CoreStateMachine::stop Aug 27 12:16:23 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:23 smp volumio[1136]: UNSET VOLATILE Aug 27 12:16:23 smp volumio[1136]: info: CorePlayQueue::clearPlayQueue Aug 27 12:16:23 smp volumio[1136]: info: CorePlayQueue::saveQueue Aug 27 12:16:23 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:16:23 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:16:23 smp volumio[1136]: info: CoreCommandRouter::volumioPushQueue Aug 27 12:16:23 smp volumio[1136]: info: CoreStateMachine::addQueueItems Aug 27 12:16:23 smp volumio[1136]: info: CorePlayQueue::addQueueItems Aug 27 12:16:23 smp volumio[1136]: info: Adding Item to queue: mnt/USB/8660-AAC5/Music/天籁之声/卡洛儿/假如爱有天意.ape Aug 27 12:16:23 smp volumio[1136]: info: Exploding uri mnt/USB/8660-AAC5/Music/天籁之声/卡洛儿/假如爱有天意.ape in service mpd Aug 27 12:16:23 smp volumio[1136]: scanFolder - failure to stat '/mnt/USB/8660-AAC5/Music/天籁之声/卡洛儿/假如爱有天意.ape' Aug 27 12:16:23 smp volumio[1136]: info: Adding Item to queue: mnt/USB/8660-AAC5/Music/天籁之声/卡洛儿/兰花草.ape Aug 27 12:16:23 smp volumio[1136]: info: Exploding uri mnt/USB/8660-AAC5/Music/天籁之声/卡洛儿/兰花草.ape in service mpd Aug 27 12:16:23 smp volumio[1136]: scanFolder - failure to stat '/mnt/USB/8660-AAC5/Music/天籁之声/卡洛儿/兰花草.ape' Aug 27 12:16:23 smp volumio[1136]: info: Adding Item to queue: mnt/USB/8660-AAC5/Music/天籁之声/卡洛儿/知道不知道.ape Aug 27 12:16:23 smp volumio[1136]: info: Exploding uri mnt/USB/8660-AAC5/Music/天籁之声/卡洛儿/知道不知道.ape in service mpd Aug 27 12:16:23 smp volumio[1136]: scanFolder - failure to stat '/mnt/USB/8660-AAC5/Music/天籁之声/卡洛儿/知道不知道.ape' Aug 27 12:16:23 smp volumio[1136]: info: Adding Item to queue: mnt/USB/B5AE-AA99/12.【无损顶级车载HIFI女声人声合集】/008.【巅峰煲跌皇】月满西楼.wav Aug 27 12:16:23 smp volumio[1136]: info: Exploding uri mnt/USB/B5AE-AA99/12.【无损顶级车载HIFI女声人声合集】/008.【巅峰煲跌皇】月满西楼.wav in service mpd Aug 27 12:16:23 smp volumio[1136]: scanFolder - failure to stat '/mnt/USB/B5AE-AA99/12.【无损顶级车载HIFI女声人声合集】/008.【巅峰煲跌皇】月满西楼.wav' Aug 27 12:16:23 smp volumio[1136]: info: CorePlayQueue::saveQueue Aug 27 12:16:23 smp volumio[1136]: info: CoreCommandRouter::volumioPushQueue Aug 27 12:16:23 smp volumio[1136]: info: CoreStateMachine::updateTrackBlock Aug 27 12:16:23 smp volumio[1136]: info: CorePlayQueue::getTrackBlock Aug 27 12:16:23 smp volumio[1136]: info: CoreCommandRouter::volumioPlay Aug 27 12:16:23 smp volumio[1136]: UNSET VOLATILE Aug 27 12:16:23 smp volumio[1136]: info: CoreStateMachine::play index 1 Aug 27 12:16:23 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:23 smp volumio[1136]: info: CoreStateMachine::stop Aug 27 12:16:23 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:23 smp volumio[1136]: UNSET VOLATILE Aug 27 12:16:23 smp volumio[1136]: info: CoreStateMachine::play index undefined Aug 27 12:16:23 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:23 smp volumio[1136]: info: CorePlayQueue::getTrack 1 Aug 27 12:16:24 smp volumio[1136]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Aug 27 12:16:24 smp volumio[1136]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Aug 27 12:16:25 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 12:16:25 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 12:16:25 smp volumio[1136]: info: Discovery: Getting this device information Aug 27 12:16:25 smp volumio[1136]: info: CoreCommandRouter::volumioGetState Aug 27 12:16:25 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:25 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 27 12:16:25 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 27 12:16:25 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 27 12:16:38 smp kernel: usb 1-1.3: new high-speed USB device number 3 using xhci_hcd Aug 27 12:16:38 smp kernel: usb 1-1.3: New USB device found, idVendor=346d, idProduct=5678, bcdDevice= 2.00 Aug 27 12:16:38 smp kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Aug 27 12:16:38 smp kernel: usb 1-1.3: Product: Disk 2.0 Aug 27 12:16:38 smp kernel: usb 1-1.3: Manufacturer: USB Aug 27 12:16:38 smp kernel: usb 1-1.3: SerialNumber: 6706371055013054621 Aug 27 12:16:38 smp kernel: usb-storage 1-1.3:1.0: USB Mass Storage device detected Aug 27 12:16:38 smp kernel: scsi host0: usb-storage 1-1.3:1.0 Aug 27 12:16:38 smp mtp-probe[3808]: checking bus 1, device 3: "/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3" Aug 27 12:16:38 smp mtp-probe[3808]: bus: 1, device: 3 was not an MTP device Aug 27 12:16:39 smp kernel: scsi 0:0:0:0: Direct-Access VendorCo ProductCode 2.00 PQ: 0 ANSI: 4 Aug 27 12:16:39 smp kernel: sd 0:0:0:0: [sda] 122880000 512-byte logical blocks: (62.9 GB/58.6 GiB) Aug 27 12:16:39 smp kernel: sd 0:0:0:0: [sda] Write Protect is off Aug 27 12:16:39 smp kernel: sd 0:0:0:0: [sda] Mode Sense: 03 00 00 00 Aug 27 12:16:39 smp kernel: sd 0:0:0:0: [sda] No Caching mode page found Aug 27 12:16:39 smp kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through Aug 27 12:16:39 smp kernel: sda: sda1 Aug 27 12:16:39 smp kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Aug 27 12:16:39 smp kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Aug 27 12:16:39 smp udisks-glue[573]: Device file /dev/sda inserted Aug 27 12:16:39 smp udisks-glue[573]: Device file /dev/sda1 inserted Aug 27 12:16:39 smp udisks-glue[573]: Trying to automount /dev/sda1... Aug 27 12:16:40 smp udisks-glue[573]: Successfully automounted /dev/sda1 at /media/B5AE-AA99 Aug 27 12:16:40 smp udisks-glue[573]: Device file /dev/sda1 mounted at /media/B5AE-AA99 Aug 27 12:16:40 smp kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Aug 27 12:16:40 smp udisks-glue[573]: Updating DB (#2) ... Aug 27 12:16:40 smp udisks-glue[573]: volume: n/a repeat: off random: off single: off consume: off Aug 27 12:16:40 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:16:40 smp volumio[1136]: info: Aug 27 12:16:40 smp volumio[1136]: ---------------------------- MPD announces state update: update Aug 27 12:16:40 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:16:40 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:16:40 smp volumio[1136]: info: sendMpdCommand status took 2 milliseconds Aug 27 12:16:40 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:16:40 smp volumio[1136]: info: Command Router : Notfying DB Updatetrue Aug 27 12:16:40 smp volumio[1136]: info: sendMpdCommand status took 182 milliseconds Aug 27 12:16:40 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:16:40 smp volumio[1136]: info: ControllerMpd::pushState Aug 27 12:16:40 smp volumio[1136]: info: CoreCommandRouter::servicePushState Aug 27 12:16:40 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:16:40 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:40 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:16:40 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:16:40 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:40 smp volumio[1136]: 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} Aug 27 12:16:40 smp volumio[1136]: verbose: CURRENT POSITION 0 Aug 27 12:16:40 smp volumio[1136]: info: CoreStateMachine::syncState stateService stop Aug 27 12:16:40 smp volumio[1136]: info: CoreStateMachine::syncState currentStatus stop Aug 27 12:16:40 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:16:40 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:40 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:16:40 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:16:40 smp volumio[1136]: info: No code Aug 27 12:16:40 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:16:40 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:40 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:16:40 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:16:40 smp volumio[1136]: info: ------------------------------ 195ms Aug 27 12:16:42 smp volumio[1136]: info: CoreCommandRouter::Close All Modals sent Aug 27 12:16:47 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 27 12:16:47 smp volumio[1136]: info: CURURI: albums:// Aug 27 12:16:47 smp volumio[1136]: listAlbums - loading Albums from cache Aug 27 12:16:47 smp volumio[1136]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Chris%20Botti/The%20Very%20Best%20of%20Chris%20Botti/7a173ef9-1e3b-4b7e-9a38-fd8d7ea3cfb0.jpg' Aug 27 12:16:50 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 27 12:16:50 smp volumio[1136]: info: CURURI: albums://%E7%BA%AF%E9%9F%B3%E4%B9%90/%E5%8F%91%E7%83%A7%E6%B5%8B%E8%AF%95%E9%9F%B3%E5%93%8DCD Aug 27 12:16:51 smp volumio[1136]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::ClearQueue Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::stop Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:51 smp volumio[1136]: UNSET VOLATILE Aug 27 12:16:51 smp volumio[1136]: info: CorePlayQueue::clearPlayQueue Aug 27 12:16:51 smp volumio[1136]: info: CorePlayQueue::saveQueue Aug 27 12:16:51 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:16:51 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:16:51 smp volumio[1136]: info: CoreCommandRouter::volumioPushQueue Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::addQueueItems Aug 27 12:16:51 smp volumio[1136]: info: CorePlayQueue::addQueueItems Aug 27 12:16:51 smp volumio[1136]: info: Adding Item to queue: albums://%E7%BA%AF%E9%9F%B3%E4%B9%90/%E5%8F%91%E7%83%A7%E6%B5%8B%E8%AF%95%E9%9F%B3%E5%93%8DCD Aug 27 12:16:51 smp volumio[1136]: info: Exploding uri albums://%E7%BA%AF%E9%9F%B3%E4%B9%90/%E5%8F%91%E7%83%A7%E6%B5%8B%E8%AF%95%E9%9F%B3%E5%93%8DCD in service mpd Aug 27 12:16:51 smp volumio[1136]: info: CorePlayQueue::saveQueue Aug 27 12:16:51 smp volumio[1136]: info: CoreCommandRouter::volumioPushQueue Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::updateTrackBlock Aug 27 12:16:51 smp volumio[1136]: info: CorePlayQueue::getTrackBlock Aug 27 12:16:51 smp volumio[1136]: info: CoreCommandRouter::volumioPlay Aug 27 12:16:51 smp volumio[1136]: UNSET VOLATILE Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::play index 0 Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::stop Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:51 smp volumio[1136]: UNSET VOLATILE Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::play index undefined Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:51 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::startPlaybackTimer Aug 27 12:16:51 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:51 smp volumio[1136]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Stereo Test/频率特性检测 (2).mp3 Aug 27 12:16:51 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand stop Aug 27 12:16:51 smp volumio[1136]: info: sendMpdCommand stop took 7 milliseconds Aug 27 12:16:51 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand clear Aug 27 12:16:51 smp volumio[1136]: info: Aug 27 12:16:51 smp volumio[1136]: ---------------------------- MPD announces system playlist update Aug 27 12:16:51 smp volumio[1136]: info: Ignoring MPD Status Update Aug 27 12:16:51 smp volumio[1136]: info: sendMpdCommand clear took 1 milliseconds Aug 27 12:16:51 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Stereo Test/频率特性检测 (2).mp3" Aug 27 12:16:51 smp volumio[1136]: error: updateQueue error: null Aug 27 12:16:51 smp volumio[1136]: info: Aug 27 12:16:51 smp volumio[1136]: ---------------------------- MPD announces system playlist update Aug 27 12:16:51 smp volumio[1136]: info: Ignoring MPD Status Update Aug 27 12:16:51 smp volumio[1136]: info: ------------------------------ 3ms Aug 27 12:16:51 smp volumio[1136]: info: sendMpdCommand add "INTERNAL/Stereo Test/频率特性检测 (2).mp3" took 2 milliseconds Aug 27 12:16:51 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand play Aug 27 12:16:51 smp volumio[1136]: info: ------------------------------ 3ms Aug 27 12:16:51 smp volumio[1136]: info: sendMpdCommand play took 2 milliseconds Aug 27 12:16:51 smp volumio[1136]: info: Aug 27 12:16:51 smp volumio[1136]: ---------------------------- MPD announces state update: player Aug 27 12:16:51 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:16:51 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:16:51 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 27 12:16:51 smp volumio[1136]: info: sendMpdCommand status took 3 milliseconds Aug 27 12:16:51 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:16:51 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 12:16:51 smp volumio[1136]: info: sendMpdCommand clearerror took 2 milliseconds Aug 27 12:16:51 smp volumio[1136]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 27 12:16:51 smp volumio[1136]: verbose: ControllerMpd::parseTrackInfo Aug 27 12:16:51 smp volumio[1136]: info: ControllerMpd::pushState Aug 27 12:16:51 smp volumio[1136]: info: CoreCommandRouter::servicePushState Aug 27 12:16:51 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:51 smp volumio[1136]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":154,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"頻率特性檢測(2)正弦波掃描信號20Hz-20kHz","artist":"纯音乐","album":"发烧测试音响CD","uri":"INTERNAL/Stereo Test/频率特性检测 (2).mp3","trackType":"mp3"} Aug 27 12:16:51 smp volumio[1136]: verbose: CURRENT POSITION 0 Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::syncState stateService pause Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::syncState currentStatus stop Aug 27 12:16:51 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:16:51 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:51 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:16:51 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:16:51 smp volumio[1136]: info: ------------------------------ 15ms Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::ClearQueue Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::stop Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:52 smp volumio[1136]: UNSET VOLATILE Aug 27 12:16:52 smp volumio[1136]: info: CorePlayQueue::clearPlayQueue Aug 27 12:16:52 smp volumio[1136]: info: CorePlayQueue::saveQueue Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::volumioPushQueue Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::addQueueItems Aug 27 12:16:52 smp volumio[1136]: info: CorePlayQueue::addQueueItems Aug 27 12:16:52 smp volumio[1136]: info: Adding Item to queue: albums://%E7%BA%AF%E9%9F%B3%E4%B9%90/%E5%8F%91%E7%83%A7%E6%B5%8B%E8%AF%95%E9%9F%B3%E5%93%8DCD Aug 27 12:16:52 smp volumio[1136]: info: Exploding uri albums://%E7%BA%AF%E9%9F%B3%E4%B9%90/%E5%8F%91%E7%83%A7%E6%B5%8B%E8%AF%95%E9%9F%B3%E5%93%8DCD in service mpd Aug 27 12:16:52 smp volumio[1136]: info: CorePlayQueue::saveQueue Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::volumioPushQueue Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::updateTrackBlock Aug 27 12:16:52 smp volumio[1136]: info: CorePlayQueue::getTrackBlock Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::volumioPlay Aug 27 12:16:52 smp volumio[1136]: UNSET VOLATILE Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::play index 0 Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::stop Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:52 smp volumio[1136]: UNSET VOLATILE Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::play index undefined Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:16:52 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::startPlaybackTimer Aug 27 12:16:52 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Stereo Test/频率特性检测 (2).mp3 Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand stop Aug 27 12:16:52 smp volumio[1136]: info: Aug 27 12:16:52 smp volumio[1136]: ---------------------------- MPD announces state update: player Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand stop took 4 milliseconds Aug 27 12:16:52 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand clear Aug 27 12:16:52 smp volumio[1136]: info: Aug 27 12:16:52 smp volumio[1136]: ---------------------------- MPD announces system playlist update Aug 27 12:16:52 smp volumio[1136]: info: Ignoring MPD Status Update Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand status took 1 milliseconds Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand clear took 1 milliseconds Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Stereo Test/频率特性检测 (2).mp3" Aug 27 12:16:52 smp volumio[1136]: error: updateQueue error: null Aug 27 12:16:52 smp volumio[1136]: info: Aug 27 12:16:52 smp volumio[1136]: ---------------------------- MPD announces system playlist update Aug 27 12:16:52 smp volumio[1136]: info: Ignoring MPD Status Update Aug 27 12:16:52 smp volumio[1136]: info: ------------------------------ 3ms Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand add "INTERNAL/Stereo Test/频率特性检测 (2).mp3" took 2 milliseconds Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::parseTrackInfo Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand play Aug 27 12:16:52 smp volumio[1136]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 27 12:16:52 smp volumio[1136]: info: ------------------------------ 7ms Aug 27 12:16:52 smp volumio[1136]: info: ------------------------------ 4ms Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand play took 2 milliseconds Aug 27 12:16:52 smp volumio[1136]: info: Aug 27 12:16:52 smp volumio[1136]: ---------------------------- MPD announces state update: player Aug 27 12:16:52 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:16:52 smp volumio[1136]: info: Aug 27 12:16:52 smp volumio[1136]: ---------------------------- MPD announces state update: player Aug 27 12:16:52 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand status took 4 milliseconds Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand status took 6 milliseconds Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand clearerror took 4 milliseconds Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::parseTrackInfo Aug 27 12:16:52 smp volumio[1136]: info: ControllerMpd::pushState Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::servicePushState Aug 27 12:16:52 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:52 smp volumio[1136]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":154,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"頻率特性檢測(2)正弦波掃描信號20Hz-20kHz","artist":"纯音乐","album":"发烧测试音响CD","uri":"INTERNAL/Stereo Test/频率特性检测 (2).mp3","trackType":"mp3"} Aug 27 12:16:52 smp volumio[1136]: verbose: CURRENT POSITION 0 Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::syncState stateService pause Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::syncState currentStatus stop Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:16:52 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:16:52 smp volumio[1136]: info: ------------------------------ 17ms Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand clearerror took 13 milliseconds Aug 27 12:16:52 smp volumio[1136]: info: sendMpdCommand playlistinfo took 12 milliseconds Aug 27 12:16:52 smp volumio[1136]: verbose: ControllerMpd::parseTrackInfo Aug 27 12:16:52 smp volumio[1136]: info: ControllerMpd::pushState Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::servicePushState Aug 27 12:16:52 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:52 smp volumio[1136]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":154,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"頻率特性檢測(2)正弦波掃描信號20Hz-20kHz","artist":"纯音乐","album":"发烧测试音响CD","uri":"INTERNAL/Stereo Test/频率特性检测 (2).mp3","trackType":"mp3"} Aug 27 12:16:52 smp volumio[1136]: verbose: CURRENT POSITION 0 Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::syncState stateService pause Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::syncState currentStatus stop Aug 27 12:16:52 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:16:52 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:16:52 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:16:52 smp volumio[1136]: info: ------------------------------ 26ms Aug 27 12:16:57 smp volumio[1136]: info: MPD Database updated - AlbumList cache refreshed Aug 27 12:16:57 smp volumio[1136]: info: Aug 27 12:16:57 smp volumio[1136]: ---------------------------- MPD announces state update: database Aug 27 12:16:57 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:16:57 smp volumio[1136]: info: Aug 27 12:16:57 smp volumio[1136]: ---------------------------- MPD announces state update: update Aug 27 12:16:57 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:16:57 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:16:57 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:16:57 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:17:00 smp volumio[1136]: info: sendMpdCommand status took 3391 milliseconds Aug 27 12:17:00 smp volumio[1136]: info: sendMpdCommand status took 3392 milliseconds Aug 27 12:17:00 smp volumio[1136]: info: sendMpdCommand status took 3391 milliseconds Aug 27 12:17:00 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:17:00 smp volumio[1136]: info: Command Router : Notfying DB Updatefalse Aug 27 12:17:00 smp volumio[1136]: info: CoreCommandRouter::Close All Modals sent Aug 27 12:17:00 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:17:00 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 12:17:00 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:17:00 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 12:17:00 smp volumio[1136]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 27 12:17:00 smp volumio[1136]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 27 12:17:00 smp volumio[1136]: verbose: ControllerMpd::parseTrackInfo Aug 27 12:17:00 smp volumio[1136]: verbose: ControllerMpd::parseTrackInfo Aug 27 12:17:00 smp volumio[1136]: info: ControllerMpd::pushState Aug 27 12:17:00 smp volumio[1136]: info: CoreCommandRouter::servicePushState Aug 27 12:17:00 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:00 smp volumio[1136]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":154,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"頻率特性檢測(2)正弦波掃描信號20Hz-20kHz","artist":"纯音乐","album":"发烧测试音响CD","uri":"INTERNAL/Stereo Test/频率特性检测 (2).mp3","trackType":"mp3"} Aug 27 12:17:00 smp volumio[1136]: verbose: CURRENT POSITION 0 Aug 27 12:17:00 smp volumio[1136]: info: CoreStateMachine::syncState stateService pause Aug 27 12:17:00 smp volumio[1136]: info: CoreStateMachine::syncState currentStatus stop Aug 27 12:17:00 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:17:00 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:00 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:00 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:00 smp volumio[1136]: info: ControllerMpd::pushState Aug 27 12:17:00 smp volumio[1136]: info: CoreCommandRouter::servicePushState Aug 27 12:17:00 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:00 smp volumio[1136]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":154,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"頻率特性檢測(2)正弦波掃描信號20Hz-20kHz","artist":"纯音乐","album":"发烧测试音响CD","uri":"INTERNAL/Stereo Test/频率特性检测 (2).mp3","trackType":"mp3"} Aug 27 12:17:00 smp volumio[1136]: verbose: CURRENT POSITION 0 Aug 27 12:17:00 smp volumio[1136]: info: CoreStateMachine::syncState stateService pause Aug 27 12:17:00 smp volumio[1136]: info: CoreStateMachine::syncState currentStatus stop Aug 27 12:17:00 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:17:00 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:00 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:00 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:00 smp volumio[1136]: info: ------------------------------ 3493ms Aug 27 12:17:00 smp volumio[1136]: info: ------------------------------ 3492ms Aug 27 12:17:08 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 27 12:17:08 smp volumio[1136]: info: CURURI: albums://%E5%8A%89%E5%BE%B7%E8%8F%AF/%E5%9C%A8%E4%B9%8E%E6%82%A8 Aug 27 12:17:08 smp volumio[1136]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 27 12:17:08 smp volumio[1136]: info: CoreStateMachine::ClearQueue Aug 27 12:17:08 smp volumio[1136]: info: CoreStateMachine::stop Aug 27 12:17:08 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:17:08 smp volumio[1136]: UNSET VOLATILE Aug 27 12:17:08 smp volumio[1136]: info: CorePlayQueue::clearPlayQueue Aug 27 12:17:08 smp volumio[1136]: info: CorePlayQueue::saveQueue Aug 27 12:17:08 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:08 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:08 smp volumio[1136]: info: CoreCommandRouter::volumioPushQueue Aug 27 12:17:08 smp volumio[1136]: info: CoreStateMachine::addQueueItems Aug 27 12:17:08 smp volumio[1136]: info: CorePlayQueue::addQueueItems Aug 27 12:17:08 smp volumio[1136]: info: Adding Item to queue: albums://%E5%8A%89%E5%BE%B7%E8%8F%AF/%E5%9C%A8%E4%B9%8E%E6%82%A8 Aug 27 12:17:08 smp volumio[1136]: info: Exploding uri albums://%E5%8A%89%E5%BE%B7%E8%8F%AF/%E5%9C%A8%E4%B9%8E%E6%82%A8 in service mpd Aug 27 12:17:09 smp volumio[1136]: info: CorePlayQueue::saveQueue Aug 27 12:17:09 smp volumio[1136]: info: CoreCommandRouter::volumioPushQueue Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::updateTrackBlock Aug 27 12:17:09 smp volumio[1136]: info: CorePlayQueue::getTrackBlock Aug 27 12:17:09 smp volumio[1136]: info: CoreCommandRouter::volumioPlay Aug 27 12:17:09 smp volumio[1136]: UNSET VOLATILE Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::play index 0 Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::stop Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:17:09 smp volumio[1136]: UNSET VOLATILE Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::play index undefined Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:17:09 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::startPlaybackTimer Aug 27 12:17:09 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::clearAddPlayTracks NAS/nas/发烧音乐A区/刘德华全集/刘德华全集/1996.刘德华.在乎您/刘德华.在乎您.flac Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand stop Aug 27 12:17:09 smp volumio[1136]: info: Aug 27 12:17:09 smp volumio[1136]: ---------------------------- MPD announces state update: player Aug 27 12:17:09 smp volumio[1136]: info: sendMpdCommand stop took 4 milliseconds Aug 27 12:17:09 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand clear Aug 27 12:17:09 smp volumio[1136]: info: Aug 27 12:17:09 smp volumio[1136]: ---------------------------- MPD announces system playlist update Aug 27 12:17:09 smp volumio[1136]: info: Ignoring MPD Status Update Aug 27 12:17:09 smp volumio[1136]: info: sendMpdCommand status took 2 milliseconds Aug 27 12:17:09 smp volumio[1136]: info: sendMpdCommand clear took 1 milliseconds Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand add "NAS/nas/发烧音乐A区/刘德华全集/刘德华全集/1996.刘德华.在乎您/刘德华.在乎您.flac" Aug 27 12:17:09 smp volumio[1136]: error: updateQueue error: null Aug 27 12:17:09 smp volumio[1136]: info: Aug 27 12:17:09 smp volumio[1136]: ---------------------------- MPD announces system playlist update Aug 27 12:17:09 smp volumio[1136]: info: Ignoring MPD Status Update Aug 27 12:17:09 smp volumio[1136]: info: ------------------------------ 3ms Aug 27 12:17:09 smp volumio[1136]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 27 12:17:09 smp volumio[1136]: info: sendMpdCommand add "NAS/nas/发烧音乐A区/刘德华全集/刘德华全集/1996.刘德华.在乎您/刘德华.在乎您.flac" took 2 milliseconds Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::parseTrackInfo Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand play Aug 27 12:17:09 smp volumio[1136]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 27 12:17:09 smp volumio[1136]: info: ------------------------------ 6ms Aug 27 12:17:09 smp volumio[1136]: info: ------------------------------ 3ms Aug 27 12:17:09 smp volumio[1136]: info: sendMpdCommand play took 1 milliseconds Aug 27 12:17:09 smp volumio[1136]: info: Aug 27 12:17:09 smp volumio[1136]: ---------------------------- MPD announces state update: player Aug 27 12:17:09 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 27 12:17:09 smp volumio[1136]: info: sendMpdCommand status took 2 milliseconds Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 12:17:09 smp volumio[1136]: info: sendMpdCommand clearerror took 2 milliseconds Aug 27 12:17:09 smp volumio[1136]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 27 12:17:09 smp volumio[1136]: verbose: ControllerMpd::parseTrackInfo Aug 27 12:17:09 smp volumio[1136]: info: ControllerMpd::pushState Aug 27 12:17:09 smp volumio[1136]: info: CoreCommandRouter::servicePushState Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:17:09 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:09 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:09 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:09 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:09 smp volumio[1136]: 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":"NAS/nas/发烧音乐A区/刘德华全集/刘德华全集/1996.刘德华.在乎您/刘德华.在乎您.flac","trackType":"flac"} Aug 27 12:17:09 smp volumio[1136]: verbose: CURRENT POSITION 0 Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::syncState stateService stop Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::syncState currentStatus stop Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:17:09 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:09 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:09 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:09 smp volumio[1136]: info: No code Aug 27 12:17:09 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:17:09 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:09 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:09 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:09 smp volumio[1136]: info: ------------------------------ 17ms Aug 27 12:17:14 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 27 12:17:14 smp volumio[1136]: info: CURURI: albums:// Aug 27 12:17:14 smp volumio[1136]: listAlbums - loading Albums from cache Aug 27 12:17:24 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 27 12:17:24 smp volumio[1136]: info: CURURI: music-library Aug 27 12:17:25 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 27 12:17:25 smp volumio[1136]: info: CURURI: music-library/USB Aug 27 12:17:26 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 27 12:17:26 smp volumio[1136]: info: CURURI: music-library/USB/B5AE-AA99 Aug 27 12:17:28 smp volumio[1136]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%B5%E5%AD%B8%E5%8F%8B/%E6%98%A8%E5%A4%9C%E5%A4%A2%E9%AD%82%E4%B8%AD/1cfa5055-fb88-41bf-b50a-22435288cdd3.jpg' Aug 27 12:17:28 smp volumio[1136]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%B5%E5%AD%B8%E5%8F%8B/%E7%B5%B2%E7%B5%B2%E8%A8%98%E6%86%B6%E6%83%85%E6%AD%8C%E7%B2%BE%E9%81%B8/72f84639-2ac4-4f70-9fb8-05f6bdaaa679.jpg' Aug 27 12:17:28 smp volumio[1136]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%B5%E5%AD%B8%E5%8F%8B/%E7%B5%A6%E6%88%91%E8%A6%AA%E6%84%9B%E7%9A%84/7ab4132c-7092-466e-b5bc-7aaa9cb65c5a.jpg' Aug 27 12:17:34 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 27 12:17:34 smp volumio[1136]: info: CURURI: music-library/USB/B5AE-AA99/14.【无损格式支持测试】 Aug 27 12:17:35 smp volumio[1136]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 27 12:17:35 smp volumio[1136]: info: CoreStateMachine::ClearQueue Aug 27 12:17:35 smp volumio[1136]: info: CoreStateMachine::stop Aug 27 12:17:35 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:17:35 smp volumio[1136]: UNSET VOLATILE Aug 27 12:17:35 smp volumio[1136]: info: CorePlayQueue::clearPlayQueue Aug 27 12:17:35 smp volumio[1136]: info: CorePlayQueue::saveQueue Aug 27 12:17:35 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:35 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::volumioPushQueue Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::addQueueItems Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::addQueueItems Aug 27 12:17:36 smp volumio[1136]: info: Adding Item to queue: music-library/USB/B5AE-AA99/14.【无损格式支持测试】/WAV无损格式测试.wav Aug 27 12:17:36 smp volumio[1136]: info: Exploding uri music-library/USB/B5AE-AA99/14.【无损格式支持测试】/WAV无损格式测试.wav in service mpd Aug 27 12:17:36 smp volumio[1136]: info: Adding Item to queue: music-library/USB/B5AE-AA99/14.【无损格式支持测试】/只支持MP3无损格式测试.mp3 Aug 27 12:17:36 smp volumio[1136]: info: Exploding uri music-library/USB/B5AE-AA99/14.【无损格式支持测试】/只支持MP3无损格式测试.mp3 in service mpd Aug 27 12:17:36 smp volumio[1136]: info: ALBUMART /albumart?cacheid=667&web=//extralarge&path=%2Fmnt%2FUSB%2FB5AE-AA99%2F14.%E3%80%90%E6%97%A0%E6%8D%9F%E6%A0%BC%E5%BC%8F%E6%94%AF%E6%8C%81%E6%B5%8B%E8%AF%95%E3%80%91%2FWAV%E6%97%A0%E6%8D%9F%E6%A0%BC%E5%BC%8F%E6%B5%8B%E8%AF%95.wav&metadata=false Aug 27 12:17:36 smp volumio[1136]: info: URI /mnt/USB/B5AE-AA99/14.【无损格式支持测试】/WAV无损格式测试.wav Aug 27 12:17:36 smp volumio[1136]: info: ALBUMART /albumart?cacheid=667&web=//extralarge&path=%2Fmnt%2FUSB%2FB5AE-AA99%2F14.%E3%80%90%E6%97%A0%E6%8D%9F%E6%A0%BC%E5%BC%8F%E6%94%AF%E6%8C%81%E6%B5%8B%E8%AF%95%E3%80%91%2F%E5%8F%AA%E6%94%AF%E6%8C%81MP3%E6%97%A0%E6%8D%9F%E6%A0%BC%E5%BC%8F%E6%B5%8B%E8%AF%95.mp3&metadata=false Aug 27 12:17:36 smp volumio[1136]: info: URI /mnt/USB/B5AE-AA99/14.【无损格式支持测试】/只支持MP3无损格式测试.mp3 Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::saveQueue Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::volumioPushQueue Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::updateTrackBlock Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrackBlock Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::volumioPlay Aug 27 12:17:36 smp volumio[1136]: UNSET VOLATILE Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::play index 1 Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::stop Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:17:36 smp volumio[1136]: UNSET VOLATILE Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::play index undefined Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 1 Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::startPlaybackTimer Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 1 Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::clearAddPlayTracks USB/B5AE-AA99/14.【无损格式支持测试】/只支持MP3无损格式测试.mp3 Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand stop Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 1 Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:36 smp volumio[1136]: info: Prefetching next song Aug 27 12:17:36 smp volumio[1136]: info: DOING PREFETCH IN MPD Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand add "USB/B5AE-AA99/14.【无损格式支持测试】/WAV无损格式测试.wav" Aug 27 12:17:36 smp volumio[1136]: info: Aug 27 12:17:36 smp volumio[1136]: ---------------------------- MPD announces system playlist update Aug 27 12:17:36 smp volumio[1136]: info: Ignoring MPD Status Update Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand stop took 13 milliseconds Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand add "USB/B5AE-AA99/14.【无损格式支持测试】/WAV无损格式测试.wav" took 7 milliseconds Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand clear Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 27 12:17:36 smp volumio[1136]: info: Aug 27 12:17:36 smp volumio[1136]: ---------------------------- MPD announces system playlist update Aug 27 12:17:36 smp volumio[1136]: info: Ignoring MPD Status Update Aug 27 12:17:36 smp volumio[1136]: info: Aug 27 12:17:36 smp volumio[1136]: ---------------------------- MPD announces state update: options Aug 27 12:17:36 smp volumio[1136]: info: ------------------------------ 10ms Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand clear took 6 milliseconds Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand consume 1 took 6 milliseconds Aug 27 12:17:36 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand add "USB/B5AE-AA99/14.【无损格式支持测试】/只支持MP3无损格式测试.mp3" Aug 27 12:17:36 smp volumio[1136]: error: updateQueue error: null Aug 27 12:17:36 smp volumio[1136]: info: Aug 27 12:17:36 smp volumio[1136]: ---------------------------- MPD announces system playlist update Aug 27 12:17:36 smp volumio[1136]: info: Ignoring MPD Status Update Aug 27 12:17:36 smp volumio[1136]: info: ------------------------------ 11ms Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand status took 6 milliseconds Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand add "USB/B5AE-AA99/14.【无损格式支持测试】/只支持MP3无损格式测试.mp3" took 6 milliseconds Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand play Aug 27 12:17:36 smp volumio[1136]: info: ControllerMpd::pushState Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::servicePushState Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 1 Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 1 Aug 27 12:17:36 smp volumio[1136]: 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} Aug 27 12:17:36 smp volumio[1136]: verbose: CURRENT POSITION 1 Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::syncState stateService stop Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::syncState currentStatus stop Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 1 Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:36 smp volumio[1136]: info: No code Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 1 Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:36 smp volumio[1136]: info: ------------------------------ 36ms Aug 27 12:17:36 smp volumio[1136]: info: Aug 27 12:17:36 smp volumio[1136]: ---------------------------- MPD announces state update: player Aug 27 12:17:36 smp volumio[1136]: info: ------------------------------ 32ms Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand play took 27 milliseconds Aug 27 12:17:36 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:17:36 smp volumio[1136]: info: Aug 27 12:17:36 smp volumio[1136]: ---------------------------- MPD announces state update: player Aug 27 12:17:36 smp volumio[1136]: info: ControllerMpd::getState Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand status took 10 milliseconds Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand status took 9 milliseconds Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand clearerror took 7 milliseconds Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::parseState Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::parseTrackInfo Aug 27 12:17:36 smp volumio[1136]: info: ControllerMpd::pushState Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::servicePushState Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::startPlaybackTimer Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:36 smp volumio[1136]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":4,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"只支持MP3无损格式测试.mp3","artist":null,"album":null,"uri":"USB/B5AE-AA99/14.【无损格式支持测试】/只支持MP3无损格式测试.mp3","trackType":"mp3"} Aug 27 12:17:36 smp volumio[1136]: verbose: CURRENT POSITION 0 Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::syncState stateService pause Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::syncState currentStatus stop Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:36 smp volumio[1136]: info: ------------------------------ 30ms Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand clearerror took 13 milliseconds Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand playlistinfo took 13 milliseconds Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::parseTrackInfo Aug 27 12:17:36 smp volumio[1136]: info: ControllerMpd::pushState Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::servicePushState Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:36 smp volumio[1136]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":4,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"只支持MP3无损格式测试.mp3","artist":null,"album":null,"uri":"USB/B5AE-AA99/14.【无损格式支持测试】/只支持MP3无损格式测试.mp3","trackType":"mp3"} Aug 27 12:17:36 smp volumio[1136]: verbose: CURRENT POSITION 0 Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::syncState stateService pause Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::syncState currentStatus stop Aug 27 12:17:36 smp volumio[1136]: info: CoreStateMachine::pushState Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::volumioPushState Aug 27 12:17:36 smp volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 12:17:36 smp volumio[1136]: info: ------------------------------ 31ms Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:36 smp volumio[1136]: info: CorePlayQueue::getTrack 1 Aug 27 12:17:36 smp volumio[1136]: info: Prefetching next song Aug 27 12:17:36 smp volumio[1136]: info: DOING PREFETCH IN MPD Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand add "USB/B5AE-AA99/14.【无损格式支持测试】/只支持MP3无损格式测试.mp3" Aug 27 12:17:36 smp volumio[1136]: info: Aug 27 12:17:36 smp volumio[1136]: ---------------------------- MPD announces system playlist update Aug 27 12:17:36 smp volumio[1136]: info: Ignoring MPD Status Update Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand add "USB/B5AE-AA99/14.【无损格式支持测试】/只支持MP3无损格式测试.mp3" took 3 milliseconds Aug 27 12:17:36 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 27 12:17:36 smp volumio[1136]: info: ------------------------------ 4ms Aug 27 12:17:36 smp volumio[1136]: info: sendMpdCommand consume 1 took 1 milliseconds Aug 27 12:17:39 smp volumio[1136]: info: CoreStateMachine::startPlaybackTimer Aug 27 12:17:39 smp volumio[1136]: info: CorePlayQueue::getTrack 1 Aug 27 12:17:39 smp volumio[1136]: info: CorePlayQueue::getTrack 1 Aug 27 12:17:39 smp volumio[1136]: info: CorePlayQueue::getTrack 0 Aug 27 12:17:39 smp volumio[1136]: info: Prefetching next song Aug 27 12:17:39 smp volumio[1136]: info: DOING PREFETCH IN MPD Aug 27 12:17:39 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand add "USB/B5AE-AA99/14.【无损格式支持测试】/WAV无损格式测试.wav" Aug 27 12:17:39 smp volumio[1136]: info: Aug 27 12:17:39 smp volumio[1136]: ---------------------------- MPD announces system playlist update Aug 27 12:17:39 smp volumio[1136]: info: Ignoring MPD Status Update Aug 27 12:17:39 smp volumio[1136]: info: sendMpdCommand add "USB/B5AE-AA99/14.【无损格式支持测试】/WAV无损格式测试.wav" took 2 milliseconds Aug 27 12:17:39 smp volumio[1136]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 27 12:17:39 smp volumio[1136]: info: ------------------------------ 4ms Aug 27 12:17:39 smp volumio[1136]: info: sendMpdCommand consume 1 took 1 milliseconds Aug 27 12:17:41 smp volumio[1136]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 12:17:41 smp volumio[1136]: { Error: connect ETIMEDOUT 128.242.240.91:443 Aug 27 12:17:41 smp volumio[1136]: at Object._errnoException (util.js:1022:11) Aug 27 12:17:41 smp volumio[1136]: at _exceptionWithHostPort (util.js:1044:20) Aug 27 12:17:41 smp volumio[1136]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Aug 27 12:17:41 smp volumio[1136]: code: 'ETIMEDOUT', Aug 27 12:17:41 smp volumio[1136]: errno: 'ETIMEDOUT', Aug 27 12:17:41 smp volumio[1136]: syscall: 'connect', Aug 27 12:17:41 smp volumio[1136]: address: '128.242.240.91', Aug 27 12:17:41 smp volumio[1136]: port: 443 } Aug 27 12:17:41 smp volumio[1136]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 12:17:41 smp sudo[3970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-27 12:16 Aug 27 12:17:41 smp sudo[3970]: 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="14acf028cf46278bd3fd3dd02523424a9bc825bf" VOLUMIO_FE_VERSION="74f64fbba9dc8053dc27ed7125863d6ad6533965" VOLUMIO_BE_VERSION="0a6008ded215bf284d5d4cd9c4df3333cb320899" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Apr 24 17:39:58 CEST 2021" VOLUMIO_VERSION="2.882" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="1a98a01eef5aa5927a5874c2d3c1b0dc"