-- Logs begin at Sat 2025-05-24 22:28:47 MSK, end at Sat 2025-05-24 22:48:36 MSK. -- May 24 22:47:00 volumio kernel: sd 1:0:0:0: [sdb] Synchronizing SCSI cache May 24 22:47:00 volumio kernel: sd 1:0:0:0: [sdb] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=DRIVER_OK May 24 22:47:00 volumio sudo[17255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda5 May 24 22:47:00 volumio sudo[17255]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 22:47:00 volumio ntfs-3g[2490]: Unmounting /dev/sda5 () May 24 22:47:00 volumio ntfs-3g[2490]: Failed to sync device /dev/sda5: No such device May 24 22:47:00 volumio ntfs-3g[2490]: Failed to close volume /dev/sda5: No such device May 24 22:47:00 volumio systemd[1]: media-92A816A5A81687BD.mount: Succeeded. May 24 22:47:00 volumio sudo[17255]: pam_unix(sudo:session): session closed for user root May 24 22:47:00 volumio volumio[1391]: info: sendMpdCommand status took 876 milliseconds May 24 22:47:00 volumio volumio[1391]: info: sendMpdCommand status took 875 milliseconds May 24 22:47:00 volumio volumio[1391]: info: sendMpdCommand status took 873 milliseconds May 24 22:47:00 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:00 volumio volumio[1391]: info: Command Router : Notfying DB Updatetrue May 24 22:47:00 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:00 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:00 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 22:47:00 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:00 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 22:47:00 volumio volumio[1391]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4.4/1-1.4.4:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/6d6f4cda-01 /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.4.4:1.0-scsi-0:0:0:0-part1 /dev/disk/by-uuid/80B9-C9AB /dev/disk/by-id/usb-Kingston_XS2000_50026B728201FCF9-0:0-part1 /dev/disk/by-label/KINGSTON","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4.4/1-1.4.4:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"27","ID_BUS":"usb","ID_FS_LABEL":"KINGSTON","ID_FS_LABEL_ENC":"KINGSTON","ID_FS_TYPE":"exfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"80B9-C9AB","ID_FS_UUID_ENC":"80B9-C9AB","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"XS2000","ID_MODEL_ENC":"XS2000\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"176b","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"2000404480","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"6d6f4cda-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"6d6f4cda","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.4.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_4_4_1_0-scsi-0_0_0_0","ID_REVISION":"0100","ID_SERIAL":"Kingston_XS2000_50026B728201FCF9-0:0","ID_SERIAL_SHORT":"50026B728201FCF9","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Kingston","ID_VENDOR_ENC":"Kingston","ID_VENDOR_ID":"0951","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"2505","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"5802704"} May 24 22:47:00 volumio sudo[17266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1 May 24 22:47:00 volumio sudo[17266]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 22:47:00 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK May 24 22:47:00 volumio systemd[1]: media-KINGSTON.mount: Succeeded. May 24 22:47:00 volumio mount.exfat[1516]: failed to write super block May 24 22:47:00 volumio kernel: xhci_hcd 0000:01:00.0: WARN Can't disable streams for endpoint 0x82, streams are being disabled already May 24 22:47:00 volumio sudo[17266]: pam_unix(sudo:session): session closed for user root May 24 22:47:00 volumio volumio[1391]: info: May 24 22:47:00 volumio volumio[1391]: ---------------------------- MPD announces system playlist update May 24 22:47:00 volumio volumio[1391]: info: Ignoring MPD Status Update May 24 22:47:00 volumio volumio[1391]: info: May 24 22:47:00 volumio volumio[1391]: ---------------------------- MPD announces system playlist update May 24 22:47:00 volumio volumio[1391]: info: Ignoring MPD Status Update May 24 22:47:00 volumio volumio[1391]: info: May 24 22:47:00 volumio volumio[1391]: ---------------------------- MPD announces system playlist update May 24 22:47:00 volumio volumio[1391]: info: Ignoring MPD Status Update May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 1569 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 1568 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 1567 milliseconds May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: info: Command Router : Notfying DB Updatetrue May 24 22:47:01 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 22:47:01 volumio volumio[1391]: info: MPD Database updated - AlbumList cache refreshed May 24 22:47:01 volumio volumio[1391]: info: May 24 22:47:01 volumio volumio[1391]: ---------------------------- MPD announces state update: database May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: May 24 22:47:01 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:01 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: MPD Database updated - AlbumList cache refreshed May 24 22:47:01 volumio volumio[1391]: info: May 24 22:47:01 volumio volumio[1391]: ---------------------------- MPD announces state update: database May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: May 24 22:47:01 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:01 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: MPD Database updated - AlbumList cache refreshed May 24 22:47:01 volumio volumio[1391]: info: May 24 22:47:01 volumio volumio[1391]: ---------------------------- MPD announces state update: database May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: May 24 22:47:01 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:01 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 1939 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 1938 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 1938 milliseconds May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: info: Command Router : Notfying DB Updatetrue May 24 22:47:01 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 2268 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 2267 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 2266 milliseconds May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: info: Command Router : Notfying DB Updatetrue May 24 22:47:01 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 22:47:01 volumio volumio[1391]: info: May 24 22:47:01 volumio volumio[1391]: ---------------------------- MPD announces state update: player May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand stop took 2178 milliseconds May 24 22:47:01 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 1897 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 1896 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 1895 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand playlistinfo took 1351 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand playlistinfo took 1350 milliseconds May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseTrackInfo May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseTrackInfo May 24 22:47:01 volumio volumio[1391]: info: CoreStateMachine::play index undefined May 24 22:47:01 volumio volumio[1391]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 22:47:01 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:01 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:01 volumio volumio[1391]: info: CorePlayQueue::getTrack 10 May 24 22:47:01 volumio volumio[1391]: verbose: STATE SERVICE {"status":"play","position":0,"seek":67118,"duration":272,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"4534 Kbps","isStreaming":false,"title":"All I Ask","artist":"Adele","album":"25","uri":"USB/KINGSTON/Adele - 25 in Master Audio Definition (Digital Studio Sound XL Recordings) Hi-Res/10. Adele - All I Ask.flac","trackType":"flac"} May 24 22:47:01 volumio volumio[1391]: verbose: CURRENT POSITION 10 May 24 22:47:01 volumio volumio[1391]: info: CoreStateMachine::syncState stateService play May 24 22:47:01 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:01 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:01 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:01 volumio volumio[1391]: info: CorePlayQueue::getTrack 10 May 24 22:47:01 volumio volumio[1391]: verbose: STATE SERVICE {"status":"play","position":0,"seek":67118,"duration":272,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"4534 Kbps","isStreaming":false,"title":"All I Ask","artist":"Adele","album":"25","uri":"USB/KINGSTON/Adele - 25 in Master Audio Definition (Digital Studio Sound XL Recordings) Hi-Res/10. Adele - All I Ask.flac","trackType":"flac"} May 24 22:47:01 volumio volumio[1391]: verbose: CURRENT POSITION 10 May 24 22:47:01 volumio volumio[1391]: info: CoreStateMachine::syncState stateService play May 24 22:47:01 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus play May 24 22:47:01 volumio volumio[1391]: info: Received an update from plugin. extracting info from payload May 24 22:47:01 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:01 volumio volumio[1391]: info: CorePlayQueue::getTrack 10 May 24 22:47:01 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 22:47:01 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:01 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:01 volumio volumio[1391]: info: CorePlayQueue::getTrack 10 May 24 22:47:01 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:01 volumio volumio[1391]: info: CorePlayQueue::getTrack 10 May 24 22:47:01 volumio volumio[1391]: info: ------------------------------ 2341ms May 24 22:47:01 volumio volumio[1391]: info: ------------------------------ 2342ms May 24 22:47:01 volumio volumio[1391]: info: CoreStateMachine::updateTrackBlock May 24 22:47:01 volumio volumio[1391]: info: CorePlayQueue::getTrackBlock May 24 22:47:01 volumio volumio[1391]: info: May 24 22:47:01 volumio volumio[1391]: ---------------------------- MPD announces system playlist update May 24 22:47:01 volumio volumio[1391]: info: Ignoring MPD Status Update May 24 22:47:01 volumio volumio[1391]: error: updateQueue error: null May 24 22:47:01 volumio volumio[1391]: info: MPD Database updated - AlbumList cache refreshed May 24 22:47:01 volumio volumio[1391]: info: May 24 22:47:01 volumio volumio[1391]: ---------------------------- MPD announces state update: database May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: May 24 22:47:01 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:01 volumio volumio[1391]: error: updateQueue error: null May 24 22:47:01 volumio volumio[1391]: info: ------------------------------ 1027ms May 24 22:47:01 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:01 volumio volumio[1391]: info: ------------------------------ 1027ms May 24 22:47:01 volumio volumio[1391]: info: ------------------------------ 1026ms May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand playlistinfo took 732 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand playlistinfo took 733 milliseconds May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseTrackInfo May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseTrackInfo May 24 22:47:01 volumio volumio[1391]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 24 22:47:01 volumio volumio[1391]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 24 22:47:01 volumio volumio[1391]: info: ------------------------------ 2349ms May 24 22:47:01 volumio volumio[1391]: info: ------------------------------ 2348ms May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 779 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 789 milliseconds May 24 22:47:01 volumio volumio[1391]: info: sendMpdCommand status took 789 milliseconds May 24 22:47:01 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 10 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 10 May 24 22:47:02 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:02 volumio volumio[1391]: verbose: CURRENT POSITION 10 May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus play May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::stPlaybackTimer May 24 22:47:02 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:02 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: No code May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 922ms May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 923ms May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand status took 951 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand status took 952 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand status took 953 milliseconds May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio dhcpcd[1056]: eth0: probing for an IPv4LL address May 24 22:47:02 volumio dhcpcd[1056]: eth0: DHCP lease expired May 24 22:47:02 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:02 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: No code May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:02 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: No code May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio dhcpcd[1056]: eth0: soliciting a DHCP lease May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 1103ms May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 1104ms May 24 22:47:02 volumio dhcpcd[1168]: eth0: probing for an IPv4LL address May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand status took 1244 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand status took 1244 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand status took 1245 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand playlistinfo took 898 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand playlistinfo took 898 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand playlistinfo took 560 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand playlistinfo took 561 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand status took 553 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand playlistinfo took 552 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand playlistinfo took 552 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand playlistinfo took 553 milliseconds May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio dhcpcd[1168]: eth0: DHCP lease expired May 24 22:47:02 volumio dhcpcd[1168]: eth0: soliciting a DHCP lease May 24 22:47:02 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseTrackInfo May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseTrackInfo May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseTrackInfo May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseTrackInfo May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseTrackInfo May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseTrackInfo May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseTrackInfo May 24 22:47:02 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:02 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: No code May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:02 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: No code May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 24 22:47:02 volumio volumio[1391]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 24 22:47:02 volumio volumio[1391]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 24 22:47:02 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:02 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: No code May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 24 22:47:02 volumio volumio[1391]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 1340ms May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 1341ms May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 2968ms May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 2967ms May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 2964ms May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 648ms May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 2545ms May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 2544ms May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 2543ms May 24 22:47:02 volumio volumio[1391]: error: updateQueue error: null May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand status took 673 milliseconds May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 676ms May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand status took 673 milliseconds May 24 22:47:02 volumio volumio[1391]: info: sendMpdCommand status took 673 milliseconds May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:02 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:02 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: No code May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:02 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: No code May 24 22:47:02 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:02 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:02 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 718ms May 24 22:47:02 volumio volumio[1391]: info: ------------------------------ 719ms May 24 22:47:02 volumio volumio[1391]: info: touch_display: Setting screensaver timeout to 0 seconds. May 24 22:47:02 volumio volumio[1391]: info: touch_display: Setting screensaver timeout to 3600 seconds. May 24 22:47:03 volumio volumio[1391]: info: peppy_screensaver: Start PeppyMeter May 24 22:47:04 volumio volumio[1391]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/92A816A5A81687BD May 24 22:47:04 volumio volumio[1391]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/KINGSTON May 24 22:47:05 volumio volumio[1391]: info: Scanning removed location : "USB/92A816A5A81687BD" May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: info: May 24 22:47:05 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: info: May 24 22:47:05 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: info: May 24 22:47:05 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: info: May 24 22:47:05 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: info: May 24 22:47:05 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 5 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 4 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 4 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 4 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 4 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 4 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 3 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 3 milliseconds May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:05 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: No code May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:05 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: No code May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:05 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: No code May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:05 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: No code May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: ------------------------------ 163ms May 24 22:47:05 volumio volumio[1391]: info: ------------------------------ 163ms May 24 22:47:05 volumio volumio[1391]: info: ------------------------------ 162ms May 24 22:47:05 volumio volumio[1391]: info: ------------------------------ 162ms May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: info: May 24 22:47:05 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: info: May 24 22:47:05 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: info: May 24 22:47:05 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 167 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 167 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 6 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 5 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 4 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 4 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 3 milliseconds May 24 22:47:05 volumio volumio[1391]: info: sendMpdCommand status took 3 milliseconds May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:47:05 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:05 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: No code May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:05 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: No code May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:05 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: No code May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:47:05 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: No code May 24 22:47:05 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:47:05 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:05 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:47:05 volumio volumio[1391]: info: ------------------------------ 315ms May 24 22:47:05 volumio volumio[1391]: info: ------------------------------ 155ms May 24 22:47:05 volumio volumio[1391]: info: ------------------------------ 154ms May 24 22:47:05 volumio volumio[1391]: info: ------------------------------ 153ms May 24 22:47:06 volumio ntpd[853]: Soliciting pool server 46.148.143.150 May 24 22:47:07 volumio dhcpcd[1168]: eth0: using IPv4LL address 169.254.124.203 May 24 22:47:07 volumio avahi-daemon[708]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.124.203. May 24 22:47:07 volumio dhcpcd[1168]: eth0: adding route to 169.254.0.0/16 May 24 22:47:07 volumio avahi-daemon[708]: New relevant interface eth0.IPv4 for mDNS. May 24 22:47:07 volumio avahi-daemon[708]: Registering new address record for 169.254.124.203 on eth0.IPv4. May 24 22:47:07 volumio ntpd[853]: Soliciting pool server 93.95.100.85 May 24 22:47:07 volumio dhcpcd[1056]: eth0: using IPv4LL address 169.254.101.124 May 24 22:47:07 volumio dhcpcd[1056]: eth0: adding route to 169.254.0.0/16 May 24 22:47:07 volumio dhcpcd[1056]: eth0: adding default route May 24 22:47:07 volumio avahi-daemon[708]: Registering new address record for 169.254.101.124 on eth0.IPv4. May 24 22:47:08 volumio volumio[1391]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 May 24 22:47:08 volumio ntpd[853]: Soliciting pool server 91.201.254.110 May 24 22:47:09 volumio ntpd[853]: Listen normally on 9 eth0 169.254.124.203:123 May 24 22:47:09 volumio ntpd[853]: Listen normally on 10 eth0 169.254.101.124:123 May 24 22:47:09 volumio ntpd[853]: 93.95.100.85 local addr 192.168.1.216 -> 169.254.101.124 May 24 22:47:09 volumio ntpd[853]: 46.148.143.150 local addr 192.168.1.216 -> 169.254.101.124 May 24 22:47:09 volumio ntpd[853]: new interface(s) found: waking up resolver May 24 22:47:11 volumio dhcpcd[1056]: eth0: carrier lost May 24 22:47:11 volumio dhcpcd[1168]: eth0: carrier lost May 24 22:47:11 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Down May 24 22:47:11 volumio avahi-daemon[708]: Withdrawing address record for 169.254.101.124 on eth0. May 24 22:47:11 volumio avahi-daemon[708]: Withdrawing address record for 169.254.124.203 on eth0. May 24 22:47:11 volumio avahi-daemon[708]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.124.203. May 24 22:47:11 volumio dhcpcd[1056]: eth0: deleting route to 169.254.0.0/16 May 24 22:47:11 volumio dhcpcd[1056]: eth0: deleting default route May 24 22:47:11 volumio avahi-daemon[708]: Interface eth0.IPv4 no longer relevant for mDNS. May 24 22:47:11 volumio volumio[1391]: info: Discovery: A device disappeared from network May 24 22:47:11 volumio volumio[1391]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined May 24 22:47:11 volumio dhcpcd[1168]: eth0: deleting route to 169.254.0.0/16 May 24 22:47:11 volumio ifplugd(eth0)[882]: Link beat lost. May 24 22:47:12 volumio ntpd[853]: Deleting interface #9 eth0, 169.254.124.203#123, interface stats: received=0, sent=0, dropped=0, active_time=3 secs May 24 22:47:12 volumio ntpd[853]: Deleting interface #10 eth0, 169.254.101.124#123, interface stats: received=0, sent=1, dropped=1, active_time=3 secs May 24 22:47:12 volumio ntpd[853]: 46.148.143.150 local addr 169.254.101.124 -> May 24 22:47:12 volumio ntpd[853]: 93.95.100.85 local addr 169.254.101.124 -> May 24 22:47:14 volumio dhcpcd[1168]: eth0: carrier acquired May 24 22:47:14 volumio dhcpcd[1056]: eth0: carrier acquired May 24 22:47:14 volumio dhcpcd[1056]: eth0: IAID 67:c5:df:85 May 24 22:47:14 volumio dhcpcd[1168]: eth0: IAID 67:c5:df:85 May 24 22:47:14 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx May 24 22:47:14 volumio ntpd[853]: error resolving pool 3.debian.pool.ntp.org: System error (-11) May 24 22:47:14 volumio ifplugd(eth0)[882]: Link beat detected. May 24 22:47:14 volumio dhcpcd[1056]: eth0: soliciting a DHCP lease May 24 22:47:14 volumio dhcpcd[1168]: eth0: soliciting an IPv6 router May 24 22:47:14 volumio dhcpcd[1168]: eth0: soliciting a DHCP lease May 24 22:47:15 volumio dhcpcd[1056]: eth0: soliciting an IPv6 router May 24 22:47:19 volumio dhcpcd[1056]: eth0: probing for an IPv4LL address May 24 22:47:19 volumio dhcpcd[1168]: eth0: probing for an IPv4LL address May 24 22:47:24 volumio dhcpcd[1056]: eth0: using IPv4LL address 169.254.101.124 May 24 22:47:24 volumio dhcpcd[1056]: eth0: adding route to 169.254.0.0/16 May 24 22:47:24 volumio dhcpcd[1056]: eth0: adding default route May 24 22:47:24 volumio avahi-daemon[708]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.101.124. May 24 22:47:24 volumio avahi-daemon[708]: New relevant interface eth0.IPv4 for mDNS. May 24 22:47:24 volumio avahi-daemon[708]: Registering new address record for 169.254.101.124 on eth0.IPv4. May 24 22:47:24 volumio dhcpcd[1168]: eth0: using IPv4LL address 169.254.124.203 May 24 22:47:24 volumio dhcpcd[1168]: eth0: adding route to 169.254.0.0/16 May 24 22:47:24 volumio avahi-daemon[708]: Registering new address record for 169.254.124.203 on eth0.IPv4. May 24 22:47:25 volumio volumio[1391]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 May 24 22:47:26 volumio ntpd[853]: Listen normally on 11 eth0 169.254.101.124:123 May 24 22:47:26 volumio ntpd[853]: Listen normally on 12 eth0 169.254.124.203:123 May 24 22:47:26 volumio ntpd[853]: new interface(s) found: waking up resolver May 24 22:47:45 volumio dhcpcd[1168]: wlan0: hardware address da:0d:17:c5:df:85 claims 192.168.1.216 May 24 22:47:46 volumio dhcpcd[1056]: eth0: offered 192.168.1.22 from 192.168.1.1 May 24 22:47:46 volumio dhcpcd[1168]: wlan0: hardware address da:0d:17:c5:df:85 claims 192.168.1.216 May 24 22:47:46 volumio dhcpcd[1168]: wlan0: 10 second defence failed for 192.168.1.216 May 24 22:47:46 volumio avahi-daemon[708]: Withdrawing address record for 192.168.1.216 on wlan0. May 24 22:47:46 volumio avahi-daemon[708]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.216. May 24 22:47:46 volumio dhcpcd[1168]: eth0: adding default route May 24 22:47:46 volumio dhcpcd[1168]: wlan0: deleting route to 192.168.1.0/24 May 24 22:47:46 volumio dhcpcd[1168]: wlan0: deleting default route via 192.168.1.1 May 24 22:47:46 volumio avahi-daemon[708]: Interface wlan0.IPv4 no longer relevant for mDNS. May 24 22:47:46 volumio volumio[1391]: info: Discovery: A device disappeared from network May 24 22:47:46 volumio volumio[1391]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined May 24 22:47:46 volumio dhcpcd[1168]: wlan0: rebinding lease of 192.168.1.216 May 24 22:47:46 volumio dhcpcd[1056]: eth0: probing address 192.168.1.22/24 May 24 22:47:46 volumio dhcpcd[1168]: wlan0: probing address 192.168.1.216/24 May 24 22:47:48 volumio ntpd[853]: Deleting interface #7 wlan0, 192.168.1.216#123, interface stats: received=51, sent=57, dropped=3, active_time=234 secs May 24 22:47:48 volumio ntpd[853]: 46.148.143.150 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 93.95.100.85 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 92.124.134.180 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 92.63.176.244 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 217.170.87.229 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 85.21.78.23 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 51.250.35.68 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 89.223.121.214 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 185.211.244.47 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 92.255.126.18 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 213.108.170.26 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 51.250.68.198 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 151.0.2.53 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 93.95.100.104 local addr 192.168.1.216 -> May 24 22:47:48 volumio ntpd[853]: 51.250.110.169 local addr 192.168.1.216 -> May 24 22:47:51 volumio dhcpcd[1168]: wlan0: leased 192.168.1.216 for 86400 seconds May 24 22:47:51 volumio avahi-daemon[708]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.216. May 24 22:47:51 volumio avahi-daemon[708]: New relevant interface wlan0.IPv4 for mDNS. May 24 22:47:51 volumio avahi-daemon[708]: Registering new address record for 192.168.1.216 on wlan0.IPv4. May 24 22:47:51 volumio dhcpcd[1168]: wlan0: adding route to 192.168.1.0/24 May 24 22:47:51 volumio dhcpcd[1168]: wlan0: adding default route via 192.168.1.1 May 24 22:47:51 volumio dhcpcd[1168]: eth0: deleting default route May 24 22:47:51 volumio dhcpcd[1056]: eth0: pid 1168 deleted default route May 24 22:47:51 volumio dhcpcd[1056]: eth0: leased 192.168.1.22 for 86400 seconds May 24 22:47:51 volumio avahi-daemon[708]: Registering new address record for 192.168.1.22 on eth0.IPv4. May 24 22:47:51 volumio dhcpcd[1056]: eth0: adding route to 192.168.1.0/24 May 24 22:47:51 volumio dhcpcd[1056]: eth0: adding default route via 192.168.1.1 May 24 22:47:51 volumio dhcpcd[1056]: eth0: deleting route to 169.254.0.0/16 May 24 22:47:51 volumio avahi-daemon[708]: Withdrawing address record for 169.254.101.124 on eth0. May 24 22:47:51 volumio avahi-daemon[708]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.101.124. May 24 22:47:51 volumio avahi-daemon[708]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.22. May 24 22:47:51 volumio avahi-daemon[708]: Withdrawing address record for 169.254.124.203 on eth0. May 24 22:47:51 volumio dhcpcd[1168]: eth0: pid 0 deleted route to 169.254.0.0/16 May 24 22:47:51 volumio dhcpcd[1168]: eth0: adding route to 169.254.0.0/16 May 24 22:47:51 volumio dhcpcd[1168]: if_route (ADD): Invalid argument May 24 22:47:51 volumio dhcpcd[1168]: eth0: pid 1056 deleted IP address 169.254.124.203/16 May 24 22:47:51 volumio dhcpcd[1168]: eth0: probing for an IPv4LL address May 24 22:47:52 volumio dhcpcd[1168]: wlan0: hardware address da:0d:17:c5:df:85 claims 192.168.1.216 May 24 22:47:52 volumio volumio[1391]: verbose: New Socket.io Connection to 192.168.1.216 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 10; ELE-L29 Build/HUAWEIELE-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 May 24 22:47:52 volumio volumio[1391]: verbose: New Socket.io Connection to 192.168.1.216 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 10; ELE-L29 Build/HUAWEIELE-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 May 24 22:47:52 volumio volumio[1391]: verbose: New Socket.io Connection to 192.168.1.216 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 10; ELE-L29 Build/HUAWEIELE-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 May 24 22:47:52 volumio volumio[1391]: verbose: New Socket.io Connection to 192.168.1.216 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 10; ELE-L29 Build/HUAWEIELE-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 May 24 22:47:52 volumio volumio[1391]: info: Received Get System Info May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 22:47:52 volumio volumio[1391]: info: Discovery: Getting this device information May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::volumioGetState May 24 22:47:52 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::volumioGetState May 24 22:47:52 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::volumioGetVisibleSources May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::volumioGetState May 24 22:47:52 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 24 22:47:52 volumio volumio[1391]: info: Received Get System Info May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 22:47:52 volumio volumio[1391]: info: Discovery: Getting this device information May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::volumioGetState May 24 22:47:52 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::volumioGetState May 24 22:47:52 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:52 volumio volumio[1391]: info: Listing playlists May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::volumioGetQueue May 24 22:47:52 volumio volumio[1391]: info: CoreStateMachine::getQueue May 24 22:47:52 volumio volumio[1391]: info: CorePlayQueue::getQueue May 24 22:47:52 volumio volumio[1391]: info: Discovery: adding 65bd9fc8-b358-455d-91ce-baf5539af315 May 24 22:47:52 volumio volumio[1391]: info: Discovery: Found device Volumio May 24 22:47:52 volumio volumio[1391]: info: CoreCommandRouter::volumioGetState May 24 22:47:52 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:47:53 volumio ntpd[853]: Listen normally on 13 eth0 192.168.1.22:123 May 24 22:47:53 volumio ntpd[853]: Listen normally on 14 wlan0 192.168.1.216:123 May 24 22:47:53 volumio ntpd[853]: Deleting interface #11 eth0, 169.254.101.124#123, interface stats: received=0, sent=10, dropped=5, active_time=27 secs May 24 22:47:53 volumio ntpd[853]: 185.211.244.47 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 92.255.126.18 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 213.108.170.26 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 51.250.68.198 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 151.0.2.53 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 93.95.100.104 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 51.250.110.169 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 92.124.134.180 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 92.63.176.244 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 217.170.87.229 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 85.21.78.23 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 51.250.35.68 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 89.223.121.214 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 46.148.143.150 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: 93.95.100.85 local addr 169.254.101.124 -> May 24 22:47:53 volumio ntpd[853]: Deleting interface #12 eth0, 169.254.124.203#123, interface stats: received=0, sent=0, dropped=0, active_time=27 secs May 24 22:47:53 volumio ntpd[853]: new interface(s) found: waking up resolver May 24 22:47:57 volumio dhcpcd[1168]: eth0: using IPv4LL address 169.254.101.124 May 24 22:47:57 volumio dhcpcd[1168]: eth0: adding route to 169.254.0.0/16 May 24 22:47:57 volumio avahi-daemon[708]: Registering new address record for 169.254.101.124 on eth0.IPv4. May 24 22:47:58 volumio ntpd[853]: Listen normally on 15 eth0 169.254.101.124:123 May 24 22:47:58 volumio ntpd[853]: new interface(s) found: waking up resolver May 24 22:47:59 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 24 22:47:59 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 24 22:48:00 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 24 22:48:00 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 24 22:48:01 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 24 22:48:01 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 24 22:48:02 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 24 22:48:05 volumio ntpd[853]: Soliciting pool server 2a02:6bf:f000:1:1::4 May 24 22:48:05 volumio ntpd[853]: Soliciting pool server 193.192.36.3 May 24 22:48:06 volumio ntpd[853]: Soliciting pool server 46.160.198.122 May 24 22:48:13 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 24 22:48:13 volumio volumio[1391]: info: Preload queue cleared May 24 22:48:14 volumio volumio[1391]: error: error May 24 22:48:14 volumio ntpd[853]: Soliciting pool server 162.159.200.1 May 24 22:48:14 volumio dhcpcd[1168]: eth0: offered 192.168.1.19 from 192.168.1.1 May 24 22:48:15 volumio dhcpcd[1168]: eth0: probing address 192.168.1.19/24 May 24 22:48:16 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 24 22:48:16 volumio volumio[1391]: info: CURURI: music-library May 24 22:48:16 volumio volumio[1391]: info: Preload queue cleared May 24 22:48:16 volumio volumio[1391]: error: error May 24 22:48:17 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 24 22:48:17 volumio volumio[1391]: info: CURURI: music-library/USB May 24 22:48:17 volumio volumio[1391]: info: Preload queue cleared May 24 22:48:18 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 24 22:48:18 volumio volumio[1391]: info: CURURI: music-library/USB/92A816A5A81687BD May 24 22:48:18 volumio volumio[1391]: error: Failed LSINFO: null May 24 22:48:18 volumio volumio[1391]: info: Preload queue cleared May 24 22:48:19 volumio dhcpcd[1168]: eth0: leased 192.168.1.19 for 86400 seconds May 24 22:48:19 volumio dhcpcd[1168]: eth0: adding route to 192.168.1.0/24 May 24 22:48:19 volumio dhcpcd[1168]: eth0: adding default route via 192.168.1.1 May 24 22:48:19 volumio avahi-daemon[708]: Registering new address record for 192.168.1.19 on eth0.IPv4. May 24 22:48:19 volumio dhcpcd[1168]: eth0: deleting route to 169.254.0.0/16 May 24 22:48:19 volumio avahi-daemon[708]: Withdrawing address record for 169.254.101.124 on eth0. May 24 22:48:20 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 24 22:48:21 volumio ntpd[853]: Listen normally on 16 eth0 192.168.1.19:123 May 24 22:48:21 volumio ntpd[853]: Deleting interface #15 eth0, 169.254.101.124#123, interface stats: received=0, sent=0, dropped=0, active_time=23 secs May 24 22:48:21 volumio ntpd[853]: new interface(s) found: waking up resolver May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 22:48:27 volumio volumio[1391]: info: Retrieving Cloud Streaming UI May 24 22:48:27 volumio volumio[1391]: info: Getting Tidal Cloud Configuration May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 22:48:27 volumio volumio[1391]: info: Getting Qobuz Cloud Configuration May 24 22:48:27 volumio volumio[1391]: info: Asking plugin for UI Config May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 22:48:27 volumio volumio[1391]: info: Getting Spotify Cloud Configuration May 24 22:48:27 volumio volumio[1391]: info: Asking plugin for UI Config May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 22:48:27 volumio volumio[1391]: info: Saving Spotify Acccount May 24 22:48:27 volumio volumio[1391]: info: Got Tidal Cloud Configuration May 24 22:48:27 volumio volumio[1391]: info: Got it May 24 22:48:27 volumio volumio[1391]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 22:48:27 volumio volumio[1391]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::volumioGetBrowseSources May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 24 22:48:27 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand rescan May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:29 volumio volumio[1391]: info: sendMpdCommand rescan took 6 milliseconds May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: sendMpdCommand status took 10 milliseconds May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:29 volumio volumio[1391]: info: Command Router : Notfying DB Updatetrue May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:29 volumio volumio[1391]: info: MPD Database updated - AlbumList cache refreshed May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: database May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: sendMpdCommand status took 69 milliseconds May 24 22:48:29 volumio volumio[1391]: info: sendMpdCommand status took 68 milliseconds May 24 22:48:29 volumio volumio[1391]: info: sendMpdCommand status took 67 milliseconds May 24 22:48:29 volumio volumio[1391]: info: sendMpdCommand status took 67 milliseconds May 24 22:48:29 volumio volumio[1391]: info: sendMpdCommand status took 65 milliseconds May 24 22:48:29 volumio volumio[1391]: info: sendMpdCommand status took 65 milliseconds May 24 22:48:29 volumio volumio[1391]: info: sendMpdCommand status took 64 milliseconds May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:29 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:29 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:29 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:29 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: No code May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:29 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: No code May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:29 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: No code May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:29 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: No code May 24 22:48:29 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:29 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:29 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:29 volumio volumio[1391]: info: ------------------------------ 200ms May 24 22:48:29 volumio volumio[1391]: info: ------------------------------ 220ms May 24 22:48:29 volumio volumio[1391]: info: ------------------------------ 219ms May 24 22:48:29 volumio volumio[1391]: info: ------------------------------ 218ms May 24 22:48:29 volumio volumio[1391]: info: MPD Database updated - AlbumList cache refreshed May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: database May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: MPD Database updated - AlbumList cache refreshed May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: database May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: MPD Database updated - AlbumList cache refreshed May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: database May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: May 24 22:48:29 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:29 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:29 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 216 milliseconds May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 216 milliseconds May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 216 milliseconds May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 60 milliseconds May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 60 milliseconds May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 60 milliseconds May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 58 milliseconds May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 58 milliseconds May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 57 milliseconds May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 55 milliseconds May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 55 milliseconds May 24 22:48:30 volumio volumio[1391]: info: sendMpdCommand status took 55 milliseconds May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:30 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:30 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: No code May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:30 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: No code May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:30 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: No code May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:30 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: No code May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:30 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: No code May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:30 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: No code May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:30 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: No code May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:30 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: No code May 24 22:48:30 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:30 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:30 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:30 volumio volumio[1391]: info: ------------------------------ 434ms May 24 22:48:30 volumio volumio[1391]: info: ------------------------------ 434ms May 24 22:48:30 volumio volumio[1391]: info: ------------------------------ 279ms May 24 22:48:30 volumio volumio[1391]: info: ------------------------------ 279ms May 24 22:48:30 volumio volumio[1391]: info: ------------------------------ 276ms May 24 22:48:30 volumio volumio[1391]: info: ------------------------------ 277ms May 24 22:48:30 volumio volumio[1391]: info: ------------------------------ 275ms May 24 22:48:30 volumio volumio[1391]: info: ------------------------------ 275ms May 24 22:48:31 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand update May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: info: May 24 22:48:33 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand update took 6 milliseconds May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: info: May 24 22:48:33 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: info: May 24 22:48:33 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: info: May 24 22:48:33 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: info: May 24 22:48:33 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 9 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 7 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 6 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 5 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 6 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 5 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 4 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 3 milliseconds May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:33 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: No code May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:33 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: No code May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:33 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: No code May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:33 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: No code May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: ------------------------------ 188ms May 24 22:48:33 volumio volumio[1391]: info: ------------------------------ 186ms May 24 22:48:33 volumio volumio[1391]: info: ------------------------------ 186ms May 24 22:48:33 volumio volumio[1391]: info: ------------------------------ 184ms May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: info: May 24 22:48:33 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: info: May 24 22:48:33 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: info: May 24 22:48:33 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 192 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 191 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 7 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 7 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 6 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 5 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 5 milliseconds May 24 22:48:33 volumio volumio[1391]: info: sendMpdCommand status took 4 milliseconds May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:33 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:33 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: No code May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:33 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: No code May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:33 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: No code May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:33 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: No code May 24 22:48:33 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:33 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:33 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:33 volumio volumio[1391]: info: ------------------------------ 369ms May 24 22:48:33 volumio volumio[1391]: info: ------------------------------ 185ms May 24 22:48:33 volumio volumio[1391]: info: ------------------------------ 184ms May 24 22:48:33 volumio volumio[1391]: info: ------------------------------ 182ms May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand rescan May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: info: May 24 22:48:34 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand rescan took 5 milliseconds May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: info: May 24 22:48:34 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: info: May 24 22:48:34 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: info: May 24 22:48:34 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: info: May 24 22:48:34 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 9 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 7 milliseconds May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 7 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 7 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 6 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 5 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 6 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 5 milliseconds May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: info: Command Router : Notfying DB Updatetrue May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:34 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: No code May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:34 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: No code May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:34 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: No code May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:34 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: No code May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: ------------------------------ 200ms May 24 22:48:34 volumio volumio[1391]: info: ------------------------------ 198ms May 24 22:48:34 volumio volumio[1391]: info: ------------------------------ 197ms May 24 22:48:34 volumio volumio[1391]: info: ------------------------------ 197ms May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: info: May 24 22:48:34 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: info: May 24 22:48:34 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: info: May 24 22:48:34 volumio volumio[1391]: ---------------------------- MPD announces state update: update May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::getState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::sendMpdCommand status May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 205 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 204 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 9 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 8 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 8 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 6 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 5 milliseconds May 24 22:48:34 volumio volumio[1391]: info: sendMpdCommand status took 5 milliseconds May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: info: Command Router : Notfying DB Updatefalse May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::Close All Modals sent May 24 22:48:34 volumio volumio[1391]: verbose: ControllerMpd::parseState May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:34 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: No code May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:34 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: No code May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:34 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: No code May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: ControllerMpd::pushState May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::servicePushState May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 24 22:48:34 volumio volumio[1391]: verbose: CURRENT POSITION 0 May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState stateService stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::syncState currentStatus stop May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: No code May 24 22:48:34 volumio volumio[1391]: info: CoreStateMachine::pushState May 24 22:48:34 volumio volumio[1391]: info: CorePlayQueue::getTrack 0 May 24 22:48:34 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState May 24 22:48:34 volumio volumio[1391]: info: ------------------------------ 373ms May 24 22:48:34 volumio volumio[1391]: info: ------------------------------ 177ms May 24 22:48:34 volumio volumio[1391]: info: ------------------------------ 176ms May 24 22:48:34 volumio volumio[1391]: info: ------------------------------ 174ms May 24 22:48:35 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 24 22:48:35 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 24 22:48:35 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 24 22:48:36 volumio volumio[1391]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 24 22:48:36 volumio volumio[1391]: Error: getaddrinfo -3007 May 24 22:48:36 volumio volumio[1391]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) May 24 22:48:36 volumio volumio[1391]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) May 24 22:48:36 volumio volumio[1391]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { May 24 22:48:36 volumio volumio[1391]: code: -3007, May 24 22:48:36 volumio volumio[1391]: errno: -3007, May 24 22:48:36 volumio volumio[1391]: syscall: 'getaddrinfo' May 24 22:48:36 volumio volumio[1391]: } May 24 22:48:36 volumio volumio[1391]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 24 22:48:36 volumio sudo[18803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-24 22:47 May 24 22:48:36 volumio sudo[18803]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="51755a7ab41793587aa858aae43b662293a9df12" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 02 Jun 2024 06:06:05 PM CEST" VOLUMIO_VERSION="3.701" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe4d1e78c5ecc2059f504259e3e8eb08"