-- Logs begin at Sat 2025-06-21 22:53:33 UTC, end at Sat 2025-06-21 23:01:45 UTC. -- Jun 21 23:00:00 volumio volumio[1017]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 21 23:00:00 volumio volumio[1017]: info: Retrying Login Due to Network Error Jun 21 23:00:03 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand rescan Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: Jun 21 23:00:04 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand rescan took 3 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: Jun 21 23:00:04 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 4 milliseconds Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: info: Command Router : Notfying DB Updatetrue Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: Jun 21 23:00:04 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 83 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 82 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 4 milliseconds Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: info: Command Router : Notfying DB Updatetrue Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: info: Command Router : Notfying DB Updatetrue Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:04 volumio volumio[1017]: info: MPD Database updated - AlbumList cache refreshed Jun 21 23:00:04 volumio volumio[1017]: info: Jun 21 23:00:04 volumio volumio[1017]: ---------------------------- MPD announces state update: database Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: Jun 21 23:00:04 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 140 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 140 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 79 milliseconds Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:04 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:04 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:04 volumio volumio[1017]: info: ------------------------------ 253ms Jun 21 23:00:04 volumio volumio[1017]: info: ------------------------------ 252ms Jun 21 23:00:04 volumio volumio[1017]: info: MPD Database updated - AlbumList cache refreshed Jun 21 23:00:04 volumio volumio[1017]: info: Jun 21 23:00:04 volumio volumio[1017]: ---------------------------- MPD announces state update: database Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: Jun 21 23:00:04 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: MPD Database updated - AlbumList cache refreshed Jun 21 23:00:04 volumio volumio[1017]: info: Jun 21 23:00:04 volumio volumio[1017]: ---------------------------- MPD announces state update: database Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: Jun 21 23:00:04 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 48 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 44 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 43 milliseconds Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:04 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:04 volumio volumio[1017]: info: ------------------------------ 245ms Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 101 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 100 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 101 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 99 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 98 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand status took 99 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 47 milliseconds Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:04 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:04 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:04 volumio volumio[1017]: info: ------------------------------ 237ms Jun 21 23:00:04 volumio volumio[1017]: info: ------------------------------ 237ms Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 74 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 75 milliseconds Jun 21 23:00:04 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 36 milliseconds Jun 21 23:00:04 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:04 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:04 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:04 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:04 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:04 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:04 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:04 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:04 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:04 volumio volumio[1017]: info: ------------------------------ 245ms Jun 21 23:00:04 volumio volumio[1017]: info: ------------------------------ 246ms Jun 21 23:00:04 volumio volumio[1017]: info: ------------------------------ 243ms Jun 21 23:00:04 volumio volumio[1017]: info: ------------------------------ 244ms Jun 21 23:00:07 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 21 23:00:10 volumio volumio[1017]: info: MyVolumio login type: Token Jun 21 23:00:11 volumio kernel: usb 3-2: USB disconnect, device number 4 Jun 21 23:00:11 volumio volumio[1017]: info: Partition removed: {"syspath":"/sys/devices/pci0000:00/0000:00:13.2/usb3/3-2/3-2:1.0/host2/target2:0:0/2:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/7631-5457 /dev/disk/by-label/TECLAST /dev/disk/by-path/pci-0000:00:13.2-usb-0:2:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/usb-Teclast_CoolFlash_FC130CC92BD9B-0:0-part1 /dev/disk/by-partuuid/d1d9ab10-01","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/pci0000:00/0000:00:13.2/usb3/3-2/3-2:1.0/host2/target2:0:0/2:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"11","ID_BUS":"usb","ID_FS_LABEL":"TECLAST","ID_FS_LABEL_ENC":"TECLAST","ID_FS_TYPE":"exfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"7631-5457","ID_FS_UUID_ENC":"7631-5457","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"CoolFlash","ID_MODEL_ENC":"CoolFlash\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"5678","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"64","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"122879936","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"d1d9ab10-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"d1d9ab10","ID_PATH":"pci-0000:00:13.2-usb-0:2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"pci-0000_00_13_2-usb-0_2_1_0-scsi-0_0_0_0","ID_REVISION":"3.20","ID_SERIAL":"Teclast_CoolFlash_FC130CC92BD9B-0:0","ID_SERIAL_SHORT":"FC130CC92BD9B","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Teclast","ID_VENDOR_ENC":"Teclast\\x20","ID_VENDOR_ID":"346d","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"2994","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"293210592"} Jun 21 23:00:11 volumio sudo[9700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1 Jun 21 23:00:11 volumio sudo[9700]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:00:11 volumio mount.exfat[9274]: non-zero reference counter (1) for '01 飘洋过海来看你（刘芳）.wav' Jun 21 23:00:11 volumio mount.exfat[9274]: failed to write super block Jun 21 23:00:11 volumio sudo[9700]: pam_unix(sudo:session): session closed for user root Jun 21 23:00:11 volumio volumio[1017]: umount: /media/TECLAST: target is busy. Jun 21 23:00:11 volumio volumio[1017]: error: Failed to umount TECLAST: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sdb1" Jun 21 23:00:11 volumio volumio[1017]: umount: /media/TECLAST: target is busy. Jun 21 23:00:11 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 21 23:00:15 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 21 23:00:16 volumio volumio[1017]: info: Scanning removed location : "USB/TECLAST" Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: Jun 21 23:00:16 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: Jun 21 23:00:16 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: Jun 21 23:00:16 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: MPD Database updated - AlbumList cache refreshed Jun 21 23:00:16 volumio volumio[1017]: info: Jun 21 23:00:16 volumio volumio[1017]: ---------------------------- MPD announces state update: database Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: Jun 21 23:00:16 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 10 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 8 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 7 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 8 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 6 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 5 milliseconds Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:16 volumio volumio[1017]: info: MPD Database updated - AlbumList cache refreshed Jun 21 23:00:16 volumio volumio[1017]: info: Jun 21 23:00:16 volumio volumio[1017]: ---------------------------- MPD announces state update: database Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: Jun 21 23:00:16 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: MPD Database updated - AlbumList cache refreshed Jun 21 23:00:16 volumio volumio[1017]: info: Jun 21 23:00:16 volumio volumio[1017]: ---------------------------- MPD announces state update: database Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: Jun 21 23:00:16 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 140 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 139 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 91 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 56 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 18 milliseconds Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:16 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:16 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:16 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:16 volumio volumio[1017]: info: ------------------------------ 223ms Jun 21 23:00:16 volumio volumio[1017]: info: ------------------------------ 223ms Jun 21 23:00:16 volumio volumio[1017]: info: ------------------------------ 222ms Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 101 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 101 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 102 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 101 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand status took 100 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 52 milliseconds Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:16 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:16 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:16 volumio volumio[1017]: info: ------------------------------ 350ms Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 69 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 32 milliseconds Jun 21 23:00:16 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 32 milliseconds Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:16 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:16 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:16 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:16 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:16 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:16 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:16 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:16 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:16 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:16 volumio volumio[1017]: info: ------------------------------ 248ms Jun 21 23:00:16 volumio volumio[1017]: info: ------------------------------ 249ms Jun 21 23:00:16 volumio volumio[1017]: info: ------------------------------ 246ms Jun 21 23:00:16 volumio volumio[1017]: info: ------------------------------ 248ms Jun 21 23:00:19 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 21 23:00:23 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 21 23:00:27 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand rescan Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:31 volumio volumio[1017]: info: Jun 21 23:00:31 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand rescan took 4 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:31 volumio volumio[1017]: info: Jun 21 23:00:31 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:31 volumio volumio[1017]: info: Jun 21 23:00:31 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:31 volumio volumio[1017]: info: Jun 21 23:00:31 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand status took 10 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand status took 10 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand status took 11 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand status took 6 milliseconds Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: info: Command Router : Notfying DB Updatetrue Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: info: Command Router : Notfying DB Updatetrue Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:31 volumio volumio[1017]: info: Jun 21 23:00:31 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand status took 148 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand status took 148 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand status took 144 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 100 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 60 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand status took 12 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand status took 6 milliseconds Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:31 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:31 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:31 volumio volumio[1017]: info: ------------------------------ 257ms Jun 21 23:00:31 volumio volumio[1017]: info: ------------------------------ 255ms Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:31 volumio volumio[1017]: info: Jun 21 23:00:31 volumio volumio[1017]: ---------------------------- MPD announces state update: update Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::getState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 114 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 76 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 40 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand status took 18 milliseconds Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand status took 17 milliseconds Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: info: Command Router : Notfying DB Updatefalse Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::Close All Modals sent Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseState Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:31 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:31 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:31 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:31 volumio volumio[1017]: info: ------------------------------ 349ms Jun 21 23:00:31 volumio volumio[1017]: info: ------------------------------ 348ms Jun 21 23:00:31 volumio volumio[1017]: info: ------------------------------ 211ms Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 21 23:00:31 volumio volumio[1017]: info: sendMpdCommand playlistinfo took 56 milliseconds Jun 21 23:00:31 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Jun 21 23:00:31 volumio volumio[1017]: info: ControllerMpd::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10877,"duration":280,"samplerate":"384 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ʈ??????��????","artist":"????","album":null,"uri":"USB/TECLAST/极限测试32-384 （4-1）不甘寂寞/01 飘洋过海来看你（刘芳）.wav","trackType":"wav"} Jun 21 23:00:31 volumio volumio[1017]: verbose: CURRENT POSITION 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState stateService pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus pause Jun 21 23:00:31 volumio volumio[1017]: info: CoreStateMachine::pushState Jun 21 23:00:31 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Jun 21 23:00:31 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Jun 21 23:00:32 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Jun 21 23:00:32 volumio volumio[1017]: info: ------------------------------ 145ms Jun 21 23:00:35 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 21 23:00:36 volumio volumio[1017]: info: Disabling MyMusic plugin airplay_emulation Jun 21 23:00:36 volumio volumio[1017]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Jun 21 23:00:36 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 23:00:36 volumio volumio[1017]: Cannot find translation for source Bandcamp Discover Jun 21 23:00:36 volumio volumio[1017]: Cannot find translation for source SoundCloud Jun 21 23:00:36 volumio volumio[1017]: info: Disabling plugin airplay_emulation Jun 21 23:00:36 volumio volumio[1017]: info: Done. Jun 21 23:00:36 volumio sudo[9768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Jun 21 23:00:36 volumio sudo[9768]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:00:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 21 23:00:36 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 21 23:00:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 21 23:00:36 volumio sudo[9768]: pam_unix(sudo:session): session closed for user root Jun 21 23:00:36 volumio volumio[1017]: info: Shairport-Sync Stopped Jun 21 23:00:39 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 21 23:00:40 volumio volumio[1017]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 21 23:00:40 volumio volumio[1017]: info: Retrying Login Due to Network Error Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 21 23:00:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 21 23:00:50 volumio volumio[1017]: info: MyVolumio login type: Token Jun 21 23:00:55 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 21 23:00:55 volumio volumio[1017]: info: CURURI: music-library Jun 21 23:00:55 volumio volumio[1017]: info: Preload queue cleared Jun 21 23:00:58 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 21 23:00:58 volumio volumio[1017]: info: CURURI: music-library/INTERNAL Jun 21 23:00:58 volumio volumio[1017]: info: Preload queue cleared Jun 21 23:00:59 volumio volumio[1017]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 23:00:59 volumio volumio[1017]: Error: connect ETIMEDOUT 162.125.17.131:80 Jun 21 23:00:59 volumio volumio[1017]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 21 23:00:59 volumio volumio[1017]: errno: -110, Jun 21 23:00:59 volumio volumio[1017]: code: 'ETIMEDOUT', Jun 21 23:00:59 volumio volumio[1017]: syscall: 'connect', Jun 21 23:00:59 volumio volumio[1017]: address: '162.125.17.131', Jun 21 23:00:59 volumio volumio[1017]: port: 80 Jun 21 23:00:59 volumio volumio[1017]: } Jun 21 23:00:59 volumio volumio[1017]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 23:01:00 volumio sudo[9875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-21 23:00 Jun 21 23:01:00 volumio sudo[9875]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:00 volumio sudo[9875]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:01 volumio volumio-remote-updater[652]: [2025-06-21 23:01:01] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 21 23:01:01 volumio volumio-remote-updater[652]: [2025-06-21 23:01:01] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 21 23:01:01 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 21 23:01:01 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 21 23:01:01 volumio systemd[1]: Started dynamicswap service. Jun 21 23:01:01 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 21 23:01:02 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 21 23:01:02 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jun 21 23:01:02 volumio systemd[1]: Stopped Volumio Backend Module. Jun 21 23:01:02 volumio systemd[1]: Started Volumio Backend Module. Jun 21 23:01:02 volumio systemd[1]: Started dynamicswap service. Jun 21 23:01:02 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 21 23:01:03 volumio volumio[9893]: info: ------------------------------------------- Jun 21 23:01:03 volumio volumio[9893]: info: ----- Volumio3 ---- Jun 21 23:01:03 volumio volumio[9893]: info: ------------------------------------------- Jun 21 23:01:03 volumio volumio[9893]: info: ----- System startup ---- Jun 21 23:01:03 volumio volumio[9893]: info: ------------------------------------------- Jun 21 23:01:04 volumio volumio[9893]: info: MYVOLUMIO Environment detected Jun 21 23:01:04 volumio volumio[9893]: info: Plugin folders cleanup Jun 21 23:01:04 volumio volumio[9893]: info: Scanning into folder /volumio/app/plugins/ Jun 21 23:01:04 volumio volumio[9893]: info: Scanning category audio_interface Jun 21 23:01:04 volumio volumio[9893]: info: Scanning category miscellanea Jun 21 23:01:04 volumio volumio[9893]: info: Scanning category music_service Jun 21 23:01:04 volumio volumio[9893]: info: Scanning category plugins.json Jun 21 23:01:04 volumio volumio[9893]: info: Scanning category system_controller Jun 21 23:01:04 volumio volumio[9893]: info: Scanning category user_interface Jun 21 23:01:04 volumio volumio[9893]: info: Scanning into folder /data/plugins/ Jun 21 23:01:04 volumio volumio[9893]: info: Scanning category audio_interface Jun 21 23:01:04 volumio volumio[9893]: info: Scanning category music_service Jun 21 23:01:04 volumio volumio[9893]: info: Scanning category system_controller Jun 21 23:01:04 volumio volumio[9893]: info: Scanning category user_interface Jun 21 23:01:04 volumio volumio[9893]: info: Plugin folders cleanup completed Jun 21 23:01:04 volumio volumio[9893]: info: ------------------------------------------- Jun 21 23:01:04 volumio volumio[9893]: info: ----- Core plugins startup ---- Jun 21 23:01:04 volumio volumio[9893]: info: ------------------------------------------- Jun 21 23:01:04 volumio volumio[9893]: info: Loading plugins from folder /volumio/app/plugins/ Jun 21 23:01:04 volumio volumio[9893]: info: Adding plugin upnp to MyMusic Plugins Jun 21 23:01:04 volumio volumio[9893]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 21 23:01:04 volumio volumio[9893]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 21 23:01:04 volumio volumio[9893]: info: Loading plugins from folder /data/plugins/ Jun 21 23:01:04 volumio volumio[9893]: info: Loading plugin "system"... Jun 21 23:01:04 volumio volumio[9893]: info: Loading plugin "appearance"... Jun 21 23:01:05 volumio volumio[9893]: info: Loading plugin "network"... Jun 21 23:01:05 volumio volumio[9893]: info: Refreshing Cached IP Addresses Jun 21 23:01:05 volumio sudo[9920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 21 23:01:05 volumio sudo[9920]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:05 volumio sudo[9920]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:05 volumio sudo[9923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 21 23:01:05 volumio sudo[9923]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:05 volumio sudo[9923]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:05 volumio volumio[9893]: info: Loading plugin "services"... Jun 21 23:01:05 volumio volumio[9893]: info: Loading plugin "alsa_controller"... Jun 21 23:01:05 volumio sudo[9935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 21 23:01:05 volumio sudo[9935]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:05 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 21 23:01:05 volumio volumio[9893]: info: Loading plugin "wizard"... Jun 21 23:01:05 volumio volumio[9893]: info: Loading plugin "networkfs"... Jun 21 23:01:05 volumio volumio[9893]: info: Starting Udev Watcher for removable devices Jun 21 23:01:05 volumio volumio[9893]: info: Ignoring mount for partition: boot Jun 21 23:01:05 volumio volumio[9893]: info: Ignoring mount for partition: volumio Jun 21 23:01:05 volumio volumio[9893]: info: Ignoring mount for partition: volumio_data Jun 21 23:01:05 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 21 23:01:05 volumio volumio[9893]: info: Loading plugin "volumio_command_line_client"... Jun 21 23:01:05 volumio volumio[9893]: info: Loading plugin "upnp"... Jun 21 23:01:05 volumio volumio[9893]: info: [1750546865760] Starting Upmpd Daemon Jun 21 23:01:05 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 21 23:01:05 volumio volumio[9893]: info: Loading plugin "my_music"... Jun 21 23:01:05 volumio volumio[9893]: info: Loading plugin "mpd"... Jun 21 23:01:06 volumio volumio[9893]: info: Loading plugin "upnp_browser"... Jun 21 23:01:06 volumio volumio[9893]: info: Loading plugin "alarm-clock"... Jun 21 23:01:06 volumio volumio[9893]: info: Plugin airplay_emulation is not enabled Jun 21 23:01:06 volumio volumio[9893]: info: Loading plugin "last_100"... Jun 21 23:01:06 volumio volumio[9893]: info: Loading plugin "webradio"... Jun 21 23:01:06 volumio volumio[9893]: info: Loading plugin "i2s_dacs"... Jun 21 23:01:06 volumio volumio[9893]: info: I2S DAC not set, start Auto-detection Jun 21 23:01:06 volumio volumio[9893]: info: Loading plugin "volumiodiscovery"... Jun 21 23:01:06 volumio volumio[9893]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 21 23:01:06 volumio volumio[9893]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 21 23:01:06 volumio node[9893]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 21 23:01:06 volumio volumio[9893]: *** WARNING *** For more information see Jun 21 23:01:06 volumio volumio[9893]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 21 23:01:06 volumio volumio[9893]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 21 23:01:06 volumio volumio[9893]: *** WARNING *** For more information see Jun 21 23:01:06 volumio node[9893]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 21 23:01:06 volumio node[9893]: *** WARNING *** For more information see Jun 21 23:01:06 volumio node[9893]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 21 23:01:06 volumio node[9893]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 21 23:01:06 volumio node[9893]: *** WARNING *** For more information see Jun 21 23:01:06 volumio volumio[9893]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 21 23:01:06 volumio volumio[9893]: info: Discovery: Started advertising with name: Volumio Jun 21 23:01:06 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 21 23:01:06 volumio volumio[9893]: info: Loading plugin "bandcamp"... Jun 21 23:01:06 volumio volumio-remote-updater[652]: [2025-06-21 23:01:06] [connect] Successful connection Jun 21 23:01:07 volumio volumio[9893]: info: Loading plugin "soundcloud"... Jun 21 23:01:08 volumio volumio[9893]: info: Plugin autostart is not enabled Jun 21 23:01:08 volumio volumio[9893]: info: Loading plugin "outputs"... Jun 21 23:01:08 volumio volumio[9893]: info: Loading plugin "albumart"... Jun 21 23:01:08 volumio volumio[9893]: info: Plugin example_plugin is not enabled Jun 21 23:01:08 volumio volumio[9893]: info: Loading plugin "inputs"... Jun 21 23:01:08 volumio volumio[9893]: info: Loading plugin "updater_comm"... Jun 21 23:01:08 volumio volumio[9893]: Forking 1 albumart workers Jun 21 23:01:08 volumio volumio[9893]: info: Plugin mpdemulation is not enabled Jun 21 23:01:08 volumio volumio[9893]: info: Loading plugin "rest_api"... Jun 21 23:01:08 volumio volumio[9893]: info: Loading plugin "websocket"... Jun 21 23:01:08 volumio volumio[9893]: info: Starting Socket.io Server version 2.3.0 Jun 21 23:01:08 volumio volumio[9893]: info: Loading plugin "fusiondsp"... Jun 21 23:01:09 volumio volumio[9893]: info: Applying required configuration parameters for plugin fusiondsp Jun 21 23:01:09 volumio volumio[9893]: info: Loading plugin "RoonBridge"... Jun 21 23:01:09 volumio volumio[9893]: Starting albumart workers Jun 21 23:01:09 volumio volumio[9893]: info: Applying required configuration parameters for plugin RoonBridge Jun 21 23:01:09 volumio volumio[9893]: info: Loading plugin "dmd2_music"... Jun 21 23:01:10 volumio volumio[9893]: info: Plugin peppymeterbasic is not enabled Jun 21 23:01:10 volumio volumio[9893]: info: Plugin peppyspectrum is not enabled Jun 21 23:01:10 volumio volumio[9893]: info: Loading i18n strings for locale zh Jun 21 23:01:10 volumio volumio[9893]: Updating browse sources language Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::initPlayerControls Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 23:01:10 volumio volumio[9893]: Express server listening on port 3000 Jun 21 23:01:10 volumio volumio[9893]: [Metrics] WebUI: 7s 986.58ms Jun 21 23:01:10 volumio volumio[9893]: info: Setting Device type: x86 Jun 21 23:01:10 volumio volumio[9893]: info: CoreStateMachine::resetVolumioState Jun 21 23:01:10 volumio volumio[9893]: info: CoreStateMachine::getcurrentVolume Jun 21 23:01:10 volumio volumio[9893]: info: CoreCommandRouter::volumioRetrievevolume Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 23:01:11 volumio volumio[9893]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 21 23:01:11 volumio volumio[9893]: info: Completed loading Core Plugins Jun 21 23:01:11 volumio volumio[9893]: info: Preparing to generate the ALSA configuration file Jun 21 23:01:11 volumio volumio[9893]: info: Volumio Network Manager: Network status updated: 2 Jun 21 23:01:11 volumio volumio[9893]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jun 21 23:01:11 volumio volumio[9893]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 21 23:01:11 volumio volumio[9893]: info: Reading ALSA contributions from plugins. Jun 21 23:01:11 volumio volumio[9893]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jun 21 23:01:11 volumio volumio[9893]: verbose: New Socket.io Connection to 192.168.6.130 from 192.168.6.165 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 2 Jun 21 23:01:11 volumio volumio[9893]: verbose: New Socket.io Connection to 192.168.6.130 from 192.168.6.165 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 3 Jun 21 23:01:11 volumio volumio[9893]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jun 21 23:01:11 volumio volumio[9893]: verbose: New Socket.io Connection to 192.168.6.130 from 192.168.6.165 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 5 Jun 21 23:01:11 volumio volumio-remote-updater[652]: [2025-06-21 23:01:11] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1750546866 101 Jun 21 23:01:11 volumio volumio[9893]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 Jun 21 23:01:11 volumio volumio[9893]: verbose: New Socket.io Connection to 192.168.6.130 from 192.168.6.165 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 7 Jun 21 23:01:11 volumio volumio[9893]: verbose: New Socket.io Connection to 192.168.6.130 from 192.168.6.165 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 8 Jun 21 23:01:11 volumio volumio[9893]: verbose: New Socket.io Connection to 192.168.6.130 from 192.168.6.165 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 9 Jun 21 23:01:11 volumio volumio[9893]: verbose: New Socket.io Connection to 192.168.6.130 from 192.168.6.165 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 10 Jun 21 23:01:11 volumio volumio[9893]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jun 21 23:01:11 volumio volumio[9893]: info: Reloading queue from file Jun 21 23:01:11 volumio volumio[9893]: info: CoreStateMachine::setRepeat true single undefined Jun 21 23:01:11 volumio volumio[9893]: info: CoreStateMachine::pushState Jun 21 23:01:11 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::volumioPushState Jun 21 23:01:11 volumio volumio[9893]: info: CoreStateMachine::setRandom null Jun 21 23:01:11 volumio volumio[9893]: info: CoreStateMachine::pushState Jun 21 23:01:11 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::volumioPushState Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:11 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 21 23:01:11 volumio volumio[9893]: info: VolumeController:: Volume=46 Mute =false Jun 21 23:01:11 volumio volumio[9893]: info: CoreStateMachine::pushState Jun 21 23:01:11 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::volumioPushState Jun 21 23:01:11 volumio volumio[9893]: info: CoreStateMachine::updateTrackBlock Jun 21 23:01:11 volumio volumio[9893]: info: CorePlayQueue::getTrackBlock Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::volumioRetrievevolume Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::volumioGetVisibleSources Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:11 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:11 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 21 23:01:11 volumio volumio[9893]: info: Received Get System Info Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 21 23:01:11 volumio volumio[9893]: info: Discovery: Getting this device information Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:11 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:11 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:11 volumio volumio[9893]: info: Listing playlists Jun 21 23:01:11 volumio volumio[9893]: info: Asound.conf file unchanged, so no further update is needed Jun 21 23:01:11 volumio volumio[9893]: info: Output device has changed, restarting MPD Jun 21 23:01:11 volumio sudo[9981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 21 23:01:11 volumio sudo[9981]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:11 volumio volumio[9893]: info: ___________ START PLUGINS ___________ Jun 21 23:01:11 volumio sudo[9981]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:11 volumio volumio[9893]: info: ControllerMpd::onStart: Initializing MPD Jun 21 23:01:11 volumio volumio[9893]: info: Creating MPD Configuration file Jun 21 23:01:11 volumio sudo[9984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 21 23:01:11 volumio sudo[9984]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:11 volumio systemd[1]: Stopping Music Player Daemon... Jun 21 23:01:11 volumio systemd[1]: mpd.service: Succeeded. Jun 21 23:01:11 volumio systemd[1]: Stopped Music Player Daemon. Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 21 23:01:11 volumio volumio[9893]: info: [1750546871977] CoreMusicLibrary::Adding element 媒体服务器 Jun 21 23:01:11 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 23:01:11 volumio systemd[1]: Starting Music Player Daemon... Jun 21 23:01:12 volumio sudo[9987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 21 23:01:12 volumio sudo[9987]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:12 volumio sudo[9987]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:12 volumio sudo[9991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 21 23:01:12 volumio sudo[9991]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 21 23:01:12 volumio volumio[9893]: info: [1750546872118] CoreMusicLibrary::Adding element Last_100 Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 21 23:01:12 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 21 23:01:12 volumio systemd[1]: mpd.service: Succeeded. Jun 21 23:01:12 volumio systemd[1]: Stopped Music Player Daemon. Jun 21 23:01:12 volumio volumio[9893]: info: [1750546872121] CoreMusicLibrary::Adding element Webradio Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 23:01:12 volumio systemd[1]: Starting Music Player Daemon... Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 21 23:01:12 volumio volumio[9893]: info: Initializing BBC Radios Jun 21 23:01:12 volumio sudo[9994]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 21 23:01:12 volumio sudo[9994]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:12 volumio sudo[9994]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 21 23:01:12 volumio volumio[9893]: info: [1750546872357] CoreMusicLibrary::Adding element Bandcamp Discover Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 23:01:12 volumio volumio[9893]: Cannot find translation for source Bandcamp Discover Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 21 23:01:12 volumio volumio[9893]: info: [1750546872378] CoreMusicLibrary::Adding element SoundCloud Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 23:01:12 volumio volumio[9893]: Cannot find translation for source Bandcamp Discover Jun 21 23:01:12 volumio volumio[9893]: Cannot find translation for source SoundCloud Jun 21 23:01:12 volumio volumio[9893]: info: Loading i18n strings for locale zh Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 21 23:01:12 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:12 volumio volumio[9893]: info: FusionDsp - mixtype--------------------- Hardware Jun 21 23:01:12 volumio volumio[9893]: info: Stopping AccessToken refresher cron for DMD2 Music Jun 21 23:01:12 volumio sudo[10008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Jun 21 23:01:12 volumio sudo[10008]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:12 volumio volumio[9893]: info: AccessToken refresher cron started for DMD2 Music Jun 21 23:01:12 volumio sudo[10008]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:12 volumio volumio[9893]: info: Volumio Calling Home Jun 21 23:01:12 volumio volumio[9893]: info: Preparing to generate the ALSA configuration file Jun 21 23:01:13 volumio volumio[9893]: info: Discovery: adding 6f6ec90e-591b-4bcb-afc5-30656dd7d7e5 Jun 21 23:01:13 volumio volumio[9893]: info: Discovery: Found device Volumio Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:13 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:13 volumio volumio[9893]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 21 23:01:13 volumio volumio[9893]: info: Reading ALSA contributions from plugins. Jun 21 23:01:13 volumio volumio[9893]: verbose: New Socket.io Connection to 192.168.6.130 from 192.168.6.165 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 12 Jun 21 23:01:13 volumio volumio[9893]: info: MPD Permissions set Jun 21 23:01:13 volumio volumio[9893]: info: MPD Permissions set Jun 21 23:01:13 volumio volumio[9893]: info: VolumeController:: Volume=46 Mute =false Jun 21 23:01:13 volumio volumio[9893]: info: CoreStateMachine::pushState Jun 21 23:01:13 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::volumioPushState Jun 21 23:01:13 volumio volumio[9893]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:13 volumio volumio[9893]: info: VolumeController::SetAlsaVolume0 Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:13 volumio volumio[9893]: info: CoreStateMachine::pushState Jun 21 23:01:13 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::volumioPushState Jun 21 23:01:13 volumio volumio[9893]: info: Volumio called home Jun 21 23:01:13 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:13 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:13 volumio volumio[9893]: info: Asound.conf file unchanged, so no further update is needed Jun 21 23:01:13 volumio volumio[9893]: info: Output device has changed, restarting MPD Jun 21 23:01:14 volumio sudo[10030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 21 23:01:14 volumio sudo[10028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 21 23:01:14 volumio sudo[10028]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:14 volumio sudo[10030]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:14 volumio sudo[10028]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:14 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 21 23:01:14 volumio systemd[1]: mpd.service: Succeeded. Jun 21 23:01:14 volumio systemd[1]: Stopped Music Player Daemon. Jun 21 23:01:14 volumio systemd[1]: Starting Music Player Daemon... Jun 21 23:01:14 volumio sudo[10033]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 21 23:01:14 volumio sudo[10033]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:14 volumio sudo[10033]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:14 volumio volumio[9893]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 21 23:01:14 volumio volumio[9893]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Jun 21 23:01:14 volumio volumio[9893]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 21 23:01:14 volumio volumio[9893]: info: camilladsp spawned new process with pid 10044, instance 1, run: true Jun 21 23:01:14 volumio volumio[9893]: info: camilladsp service started and running in background, instance 1 Jun 21 23:01:14 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:15 volumio volumio[9893]: cannot open device 'volumioHw': Device or resource busy Jun 21 23:01:15 volumio volumio[9893]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 21 23:01:15 volumio volumio[9893]: cannot open device 'volumioHw': Device or resource busy Jun 21 23:01:15 volumio volumio[9893]: info: FusionDsp loaded Jun 21 23:01:15 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 21 23:01:15 volumio sudo[10054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 21 23:01:15 volumio sudo[10054]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:15 volumio volumio[9893]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 21 23:01:15 volumio volumio[9893]: info: Adding Signal Path Element [object Object] Jun 21 23:01:15 volumio volumio[9893]: info: Adding fusiondspeq DSP Signal Path Element Jun 21 23:01:15 volumio volumio[9893]: info: FusionDsp - ---- installed callbackRead Jun 21 23:01:15 volumio volumio[9893]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 21 23:01:15 volumio sudo[10054]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:15 volumio volumio[9893]: info: MPD Permissions set Jun 21 23:01:15 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:15 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:15 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:15 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:15 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 23:01:15 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 21 23:01:15 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 23:01:15 volumio volumio[9893]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Jun 21 23:01:15 volumio volumio[9893]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jun 21 23:01:15 volumio sudo[10083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 21 23:01:15 volumio sudo[10083]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:15 volumio sudo[10081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 21 23:01:15 volumio sudo[10081]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:15 volumio sudo[10081]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:15 volumio sudo[10083]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:15 volumio sudo[10087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 21 23:01:15 volumio sudo[10087]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:16 volumio sudo[10087]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:16 volumio volumio[9893]: info: Upmpdcli Daemon Started Jun 21 23:01:16 volumio mpd[10035]: Jun 21 23:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 21 23:01:16 volumio systemd[1]: Started Music Player Daemon. Jun 21 23:01:16 volumio sudo[9984]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:16 volumio sudo[10030]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:16 volumio sudo[9991]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:16 volumio volumio[9893]: info: Completed starting Core Plugins Jun 21 23:01:16 volumio volumio[9893]: info: ------------------------------------------- Jun 21 23:01:16 volumio volumio[9893]: info: ----- MyVolumio plugins startup ---- Jun 21 23:01:16 volumio volumio[9893]: info: ------------------------------------------- Jun 21 23:01:16 volumio volumio[9893]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 21 23:01:16 volumio volumio[9893]: error: MPD error: The expression evaluated to a falsy value: Jun 21 23:01:16 volumio volumio[9893]: assert.ok(self.idling) Jun 21 23:01:16 volumio volumio[9893]: error: The expression evaluated to a falsy value: Jun 21 23:01:16 volumio volumio[9893]: assert.ok(self.idling) Jun 21 23:01:16 volumio volumio[9893]: error: MPD error: The expression evaluated to a falsy value: Jun 21 23:01:16 volumio volumio[9893]: assert.ok(self.idling) Jun 21 23:01:16 volumio volumio[9893]: error: The expression evaluated to a falsy value: Jun 21 23:01:16 volumio volumio[9893]: assert.ok(self.idling) Jun 21 23:01:16 volumio volumio[9893]: info: MPD running with PID10035 Jun 21 23:01:16 volumio volumio[9893]: ,establishing connection Jun 21 23:01:16 volumio volumio[9893]: error: updateQueue error: null Jun 21 23:01:16 volumio volumio[9893]: error: updateQueue error: null Jun 21 23:01:16 volumio sudo[9935]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:17 volumio volumio[9893]: verbose: New Socket.io Connection to 192.168.6.130 from 192.168.6.165 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 15 Jun 21 23:01:17 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::volumioGetVisibleSources Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:18 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 21 23:01:18 volumio volumio[9893]: info: Received Get System Info Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 21 23:01:18 volumio volumio[9893]: info: Discovery: Getting this device information Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:18 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:18 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:18 volumio volumio[9893]: info: Listing playlists Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::volumioGetQueue Jun 21 23:01:18 volumio volumio[9893]: info: CoreStateMachine::getQueue Jun 21 23:01:18 volumio volumio[9893]: info: CorePlayQueue::getQueue Jun 21 23:01:18 volumio volumio[9893]: info: Received Get System Info Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 21 23:01:18 volumio volumio[9893]: info: Discovery: Getting this device information Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:18 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:18 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:18 volumio volumio[9893]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 23:01:21 volumio volumio[9893]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 21 23:01:23 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 21 23:01:23 volumio volumio[9893]: info: CURURI: music-library/INTERNAL/PeppySpectrum Jun 21 23:01:23 volumio volumio[9893]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 21 23:01:23 volumio volumio[9893]: info: Preload queue cleared Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 21 23:01:24 volumio volumio[9893]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 21 23:01:24 volumio volumio[9893]: info: Adding plugin bluetooth to MyMusic Plugins Jun 21 23:01:24 volumio volumio[9893]: info: Adding plugin multiroom to MyMusic Plugins Jun 21 23:01:24 volumio volumio[9893]: info: Adding plugin metavolumio to MyMusic Plugins Jun 21 23:01:24 volumio volumio[9893]: info: Adding plugin cd_controller to MyMusic Plugins Jun 21 23:01:24 volumio volumio[9893]: info: Adding plugin qobuzconnect to MyMusic Plugins Jun 21 23:01:24 volumio volumio[9893]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 21 23:01:24 volumio volumio[9893]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 21 23:01:25 volumio volumio[9893]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 21 23:01:25 volumio volumio[9893]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 21 23:01:25 volumio volumio[9893]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 21 23:01:25 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 23:01:25 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 23:01:25 volumio volumio[9893]: info: Starting MyVolumio Remote Streaming Endpoints Jun 21 23:01:25 volumio volumio[9893]: info: MyVolumio login type: Token Jun 21 23:01:25 volumio volumio[9893]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 21 23:01:25 volumio volumio[9893]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 21 23:01:26 volumio volumio[9893]: info: Starting Streaming Service Transparent Proxy Jun 21 23:01:26 volumio volumio[9893]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 21 23:01:26 volumio volumio[9893]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 21 23:01:26 volumio volumio[9893]: info: Streaming services startup Jun 21 23:01:26 volumio volumio[9893]: info: Starting Streaming Daemon Jun 21 23:01:26 volumio sudo[10117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 21 23:01:26 volumio sudo[10117]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 23:01:26 volumio sudo[10117]: pam_unix(sudo:session): session closed for user root Jun 21 23:01:26 volumio volumio[9893]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 21 23:01:26 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 21 23:01:26 volumio volumio[9893]: info: CURURI: music-library/INTERNAL/FusionDsp Jun 21 23:01:26 volumio volumio[9893]: info: Preload queue cleared Jun 21 23:01:26 volumio volumio[9893]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 21 23:01:26 volumio volumio[9893]: info: CoreStateMachine::ClearQueue Jun 21 23:01:26 volumio volumio[9893]: info: CoreStateMachine::stop Jun 21 23:01:26 volumio volumio[9893]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 21 23:01:26 volumio volumio[9893]: info: CorePlayQueue::clearPlayQueue Jun 21 23:01:26 volumio volumio[9893]: info: CorePlayQueue::saveQueue Jun 21 23:01:26 volumio volumio[9893]: info: CoreCommandRouter::volumioPushQueue Jun 21 23:01:26 volumio volumio[9893]: info: CoreStateMachine::addQueueItems Jun 21 23:01:26 volumio volumio[9893]: info: CorePlayQueue::addQueueItems Jun 21 23:01:26 volumio volumio[9893]: info: Preload queue cleared Jun 21 23:01:26 volumio volumio[9893]: info: Adding Item to queue: music-library/INTERNAL/FusionDsp Jun 21 23:01:26 volumio volumio[9893]: info: Exploding uri music-library/INTERNAL/FusionDsp in service mpd Jun 21 23:01:26 volumio volumio[9893]: info: Preload queue cleared Jun 21 23:01:26 volumio volumio[9893]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 21 23:01:26 volumio volumio[9893]: info: CoreStateMachine::ClearQueue Jun 21 23:01:26 volumio volumio[9893]: info: CoreStateMachine::stop Jun 21 23:01:26 volumio volumio[9893]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 21 23:01:26 volumio volumio[9893]: info: CorePlayQueue::clearPlayQueue Jun 21 23:01:26 volumio volumio[9893]: info: CorePlayQueue::saveQueue Jun 21 23:01:26 volumio volumio[9893]: info: CoreCommandRouter::volumioPushQueue Jun 21 23:01:26 volumio volumio[9893]: info: CoreStateMachine::addQueueItems Jun 21 23:01:26 volumio volumio[9893]: info: CorePlayQueue::addQueueItems Jun 21 23:01:26 volumio volumio[9893]: info: Preload queue cleared Jun 21 23:01:26 volumio volumio[9893]: info: Adding Item to queue: music-library/INTERNAL/FusionDsp Jun 21 23:01:26 volumio volumio[9893]: info: Exploding uri music-library/INTERNAL/FusionDsp in service mpd Jun 21 23:01:27 volumio volumio[9893]: error: Cannot start Volumio Streaming Daemon Jun 21 23:01:27 volumio volumio[9893]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 21 23:01:27 volumio volumio[9893]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 21 23:01:27 volumio volumio[9893]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 21 23:01:27 volumio volumio[9893]: info: CoreCommandRouter::volumioPushQueue Jun 21 23:01:27 volumio volumio[9893]: info: CorePlayQueue::saveQueue Jun 21 23:01:27 volumio volumio[9893]: info: CoreCommandRouter::volumioPushQueue Jun 21 23:01:27 volumio volumio[9893]: info: CorePlayQueue::saveQueue Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::updateTrackBlock Jun 21 23:01:27 volumio volumio[9893]: info: CorePlayQueue::getTrackBlock Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::updateTrackBlock Jun 21 23:01:27 volumio volumio[9893]: info: CorePlayQueue::getTrackBlock Jun 21 23:01:27 volumio volumio[9893]: info: CoreCommandRouter::volumioPlay Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::play index 0 Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 21 23:01:27 volumio volumio[9893]: info: CoreCommandRouter::volumioPlay Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::play index 0 Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::stop Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::stop Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::play index undefined Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::play index undefined Jun 21 23:01:27 volumio volumio[9893]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 21 23:01:27 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:27 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:27 volumio volumio[9893]: info: Preload queue cleared Jun 21 23:01:27 volumio volumio[9893]: STREAMING PROXY: Starting server on port 3245 Jun 21 23:01:27 volumio volumio[9893]: Node JS runtime: 14 Jun 21 23:01:29 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 21 23:01:29 volumio volumio[9893]: info: CURURI: music-library/INTERNAL/PeppyMeterBasic Jun 21 23:01:29 volumio volumio[9893]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 21 23:01:29 volumio volumio[9893]: info: Preload queue cleared Jun 21 23:01:32 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 21 23:01:32 volumio volumio[9893]: info: CURURI: music-library/NAS Jun 21 23:01:32 volumio volumio[9893]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 21 23:01:32 volumio volumio[9893]: info: Preload queue cleared Jun 21 23:01:40 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 21 23:01:40 volumio volumio[9893]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Jun 21 23:01:40 volumio volumio[9893]: info: CoreCommandRouter::volumioGetState Jun 21 23:01:40 volumio volumio[9893]: info: CorePlayQueue::getTrack 0 Jun 21 23:01:42 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 21 23:01:42 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 23:01:42 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 21 23:01:43 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 21 23:01:43 volumio volumio[9893]: info: Preload queue cleared Jun 21 23:01:45 volumio volumio[9893]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 21 23:01:45 volumio volumio[9893]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 23:01:45 volumio volumio[9893]: TypeError: Cannot read property 'length' of undefined Jun 21 23:01:45 volumio volumio[9893]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jun 21 23:01:45 volumio volumio[9893]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jun 21 23:01:45 volumio volumio[9893]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jun 21 23:01:45 volumio volumio[9893]: at Parser.emit (events.js:400:28) Jun 21 23:01:45 volumio volumio[9893]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jun 21 23:01:45 volumio volumio[9893]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jun 21 23:01:45 volumio volumio[9893]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jun 21 23:01:45 volumio volumio[9893]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jun 21 23:01:45 volumio volumio[9893]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jun 21 23:01:45 volumio volumio[9893]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jun 21 23:01:45 volumio volumio[9893]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jun 21 23:01:45 volumio volumio[9893]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jun 21 23:01:45 volumio volumio[9893]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jun 21 23:01:45 volumio volumio[9893]: at IncomingMessage.emit (events.js:412:35) Jun 21 23:01:45 volumio volumio[9893]: at endReadableNT (internal/streams/readable.js:1333:12) Jun 21 23:01:45 volumio volumio[9893]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jun 21 23:01:45 volumio volumio[9893]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 23:01:45 volumio sudo[10152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-21 23:00 Jun 21 23:01:45 volumio sudo[10152]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"