-- Logs begin at Fri 2025-09-12 18:42:17 +07, end at Fri 2025-09-12 18:52:51 +07. -- Sep 12 18:51:04 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 12 18:51:19 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 18:51:19 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 18:51:19 volumio volumio[1023]: info: Discovery: Getting this device information Sep 12 18:51:19 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Sep 12 18:51:19 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:51:19 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 18:51:29 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Sep 12 18:51:29 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:51:29 volumio sudo[3498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 18:51:29 volumio sudo[3498]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:51:29 volumio sudo[3498]: pam_unix(sudo:session): session closed for user root Sep 12 18:51:29 volumio sudo[3503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 18:51:29 volumio sudo[3503]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:51:29 volumio sudo[3503]: pam_unix(sudo:session): session closed for user root Sep 12 18:51:30 volumio sudo[3507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 18:51:30 volumio sudo[3507]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:51:30 volumio sudo[3508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 18:51:30 volumio sudo[3508]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:51:30 volumio sudo[3507]: pam_unix(sudo:session): session closed for user root Sep 12 18:51:30 volumio sudo[3508]: pam_unix(sudo:session): session closed for user root Sep 12 18:51:37 volumio ntpd[1806]: Soliciting pool server 115.165.161.155 Sep 12 18:51:39 volumio ntpd[1806]: Soliciting pool server 2401:5b60:0:1::52 Sep 12 18:51:40 volumio ntpd[1806]: Soliciting pool server 115.165.161.155 Sep 12 18:51:47 volumio ntpd[1806]: Soliciting pool server 115.165.161.155 Sep 12 18:51:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 18:51:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 18:51:49 volumio volumio[1023]: info: Discovery: Getting this device information Sep 12 18:51:49 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Sep 12 18:51:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:51:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 18:52:09 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Sep 12 18:52:09 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:10 volumio sudo[3579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 18:52:10 volumio sudo[3579]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:52:10 volumio sudo[3581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 18:52:10 volumio sudo[3581]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:52:10 volumio sudo[3579]: pam_unix(sudo:session): session closed for user root Sep 12 18:52:10 volumio sudo[3581]: pam_unix(sudo:session): session closed for user root Sep 12 18:52:10 volumio sudo[3601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 18:52:10 volumio sudo[3601]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:52:10 volumio sudo[3605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 18:52:10 volumio sudo[3601]: pam_unix(sudo:session): session closed for user root Sep 12 18:52:10 volumio sudo[3605]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:52:10 volumio sudo[3605]: pam_unix(sudo:session): session closed for user root Sep 12 18:52:19 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 18:52:19 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 18:52:19 volumio volumio[1023]: info: Discovery: Getting this device information Sep 12 18:52:19 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Sep 12 18:52:19 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:19 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 18:52:44 volumio kernel: usb 4-1: USB disconnect, device number 3 Sep 12 18:52:44 volumio volumio[1023]: info: Partition removed: {"syspath":"/sys/devices/pci0000:00/0000:00:14.0/usb4/4-1/4-1:1.0/host6/target6:0:0/6:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partlabel/Basic\\x20data\\x20partition /dev/disk/by-partuuid/c6a0271f-2feb-4539-9888-f05c1b769be1 /dev/disk/by-id/wwn-0x5000c5004db1e052-part1 /dev/disk/by-uuid/9C1ADF411ADF16DC /dev/disk/by-id/ata-ST250DM000-1BD141_9VYGYYSY-part1 /dev/disk/by-path/pci-0000:00:14.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-label/DSD","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/pci0000:00/0000:00:14.0/usb4/4-1/4-1:1.0/host6/target6:0:0/6:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"12","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"38","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"38","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"7200","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"DSD","ID_FS_LABEL_ENC":"DSD","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"9C1ADF411ADF16DC","ID_FS_UUID_ENC":"9C1ADF411ADF16DC","ID_MODEL":"ST250DM000-1BD141","ID_MODEL_ENC":"ST250DM000-1BD141\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NAME":"Basic\\x20data\\x20partition","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"1261568","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"487133184","ID_PART_ENTRY_TYPE":"ebd0a0a2-b9e5-4433-87c0-68b6b72699c7","ID_PART_ENTRY_UUID":"c6a0271f-2feb-4539-9888-f05c1b769be1","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"2958c500-d888-03a9-4031-560a2276ea00","ID_PATH":"pci-0000:00:14.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"pci-0000_00_14_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"HP73","ID_SERIAL":"ST250DM000-1BD141_9VYGYYSY","ID_SERIAL_SHORT":"9VYGYYSY","ID_TYPE":"disk","ID_WWN":"0x5000c5004db1e052","ID_WWN_WITH_EXTENSION":"0x5000c5004db1e052","MAJOR":"8","MINOR":"17","PARTN":"1","PARTNAME":"Basic data partition","SEQNUM":"3177","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"208161797"} Sep 12 18:52:44 volumio sudo[3708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1 Sep 12 18:52:44 volumio sudo[3708]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:52:44 volumio ntfs-3g[2413]: Unmounting /dev/sdb1 (DSD) Sep 12 18:52:44 volumio systemd[1]: media-DSD.mount: Succeeded. Sep 12 18:52:44 volumio sudo[3708]: pam_unix(sudo:session): session closed for user root Sep 12 18:52:44 volumio volumio[1023]: info: Partition removed: {"syspath":"/sys/devices/pci0000:00/0000:00:14.0/usb4/4-1/4-1:1.0/host6/target6:0:0/6:0:0:1/block/sdc/sdc1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/wwn-0x5000c5002fa2c7fd-part1 /dev/disk/by-label/FLAC /dev/disk/by-path/pci-0000:00:14.0-usb-0:1:1.0-scsi-0:0:0:1-part1 /dev/disk/by-id/ata-ST3250318AS_5VMQEVKT-part1 /dev/disk/by-partuuid/960361d8-01 /dev/disk/by-uuid/62D656F4D656C845","DEVNAME":"/dev/sdc1","DEVPATH":"/devices/pci0000:00/0000:00:14.0/usb4/4-1/4-1:1.0/host6/target6:0:0/6:0:0:1/block/sdc/sdc1","DEVTYPE":"partition","DISKSEQ":"13","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"48","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"48","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"7200","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"FLAC","ID_FS_LABEL_ENC":"FLAC","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"62D656F4D656C845","ID_FS_UUID_ENC":"62D656F4D656C845","ID_MODEL":"ST3250318AS","ID_MODEL_ENC":"ST3250318AS\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:32","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"488392704","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"960361d8-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"960361d8","ID_PATH":"pci-0000:00:14.0-usb-0:1:1.0-scsi-0:0:0:1","ID_PATH_TAG":"pci-0000_00_14_0-usb-0_1_1_0-scsi-0_0_0_1","ID_REVISION":"HP35","ID_SERIAL":"ST3250318AS_5VMQEVKT","ID_SERIAL_SHORT":"5VMQEVKT","ID_TYPE":"disk","ID_WWN":"0x5000c5002fa2c7fd","ID_WWN_WITH_EXTENSION":"0x5000c5002fa2c7fd","MAJOR":"8","MINOR":"33","PARTN":"1","SEQNUM":"3187","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"208128164"} Sep 12 18:52:44 volumio sudo[3712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdc1 Sep 12 18:52:44 volumio sudo[3712]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:52:44 volumio ntfs-3g[2405]: Unmounting /dev/sdc1 (FLAC) Sep 12 18:52:44 volumio systemd[1]: media-FLAC.mount: Succeeded. Sep 12 18:52:44 volumio sudo[3712]: pam_unix(sudo:session): session closed for user root Sep 12 18:52:44 volumio ntpd[1806]: Soliciting pool server 115.165.161.155 Sep 12 18:52:45 volumio ntpd[1806]: Soliciting pool server 2404:fbc0:0:2046::c Sep 12 18:52:46 volumio ntpd[1806]: Soliciting pool server 115.165.161.155 Sep 12 18:52:48 volumio volumio[1023]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/DSD Sep 12 18:52:48 volumio volumio[1023]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/FLAC Sep 12 18:52:49 volumio volumio[1023]: info: Scanning removed location : "USB/DSD" Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 8 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 6 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 7 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 6 milliseconds Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatetrue Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatetrue Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatetrue Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 313ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 312ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 311ms Sep 12 18:52:49 volumio volumio[1023]: info: MPD Database updated - AlbumList cache refreshed Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: database Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: MPD Database updated - AlbumList cache refreshed Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: database Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: MPD Database updated - AlbumList cache refreshed Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: database Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Scanning removed location : "USB/FLAC" Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 96 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 93 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 94 milliseconds Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatefalse Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 175ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 178ms Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 273 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 272 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 268 milliseconds Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatefalse Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 333ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 334ms Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 355 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 355 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 355 milliseconds Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatefalse Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 378ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 384ms Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: MPD Database updated - AlbumList cache refreshed Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: database Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: MPD Database updated - AlbumList cache refreshed Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: database Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: MPD Database updated - AlbumList cache refreshed Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: database Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: Sep 12 18:52:49 volumio volumio[1023]: ---------------------------- MPD announces state update: update Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::getState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 16 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 16 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 15 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 15 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 16 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 16 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 16 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 16 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 15 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 4 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 4 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Sep 12 18:52:49 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatefalse Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatefalse Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatefalse Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatefalse Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatefalse Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: Command Router : Notfying DB Updatefalse Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::Close All Modals sent Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: verbose: ControllerMpd::parseState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ControllerMpd::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: 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} Sep 12 18:52:49 volumio volumio[1023]: verbose: CURRENT POSITION 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: No code Sep 12 18:52:49 volumio volumio[1023]: info: CoreStateMachine::pushState Sep 12 18:52:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:49 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 149ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 150ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 151ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 151ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 151ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 140ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 140ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 140ms Sep 12 18:52:49 volumio volumio[1023]: info: ------------------------------ 140ms Sep 12 18:52:50 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 18:52:50 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 18:52:50 volumio volumio[1023]: info: Discovery: Getting this device information Sep 12 18:52:50 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Sep 12 18:52:50 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Sep 12 18:52:50 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 18:52:51 volumio volumio[1023]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 12 18:52:51 volumio volumio[1023]: Error: connect ETIMEDOUT 151.101.78.79:80 Sep 12 18:52:51 volumio volumio[1023]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 12 18:52:51 volumio volumio[1023]: errno: -110, Sep 12 18:52:51 volumio volumio[1023]: code: 'ETIMEDOUT', Sep 12 18:52:51 volumio volumio[1023]: syscall: 'connect', Sep 12 18:52:51 volumio volumio[1023]: address: '151.101.78.79', Sep 12 18:52:51 volumio volumio[1023]: port: 80 Sep 12 18:52:51 volumio volumio[1023]: } Sep 12 18:52:51 volumio volumio[1023]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 12 18:52:51 volumio sudo[3772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-12 18:51 Sep 12 18:52:51 volumio sudo[3772]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"