-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Thu 2025-03-13 20:58:13 MSK. -- Mar 13 20:57:01 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 13 20:57:01 volumio volumio[1115]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 13 20:57:01 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 13 20:57:01 volumio volumio[1115]: info: Received Get System Version Mar 13 20:57:01 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 13 20:57:01 volumio volumio[1115]: info: Received Get System Info Mar 13 20:57:01 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 13 20:57:01 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 13 20:57:01 volumio volumio[1115]: info: Discovery: Getting this device information Mar 13 20:57:01 volumio volumio[1115]: info: CoreCommandRouter::volumioGetState Mar 13 20:57:01 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 13 20:57:05 volumio volumio[1115]: info: Setting Geolocation for MyVolumio to eu6 Mar 13 20:57:05 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 20:57:06 volumio volumio[1115]: info: Updating MyVolumio device info Mar 13 20:57:06 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 20:57:07 volumio volumio[1115]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 13 20:57:07 volumio volumio[1115]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 13 20:57:26 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 13 20:57:26 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 13 20:57:26 volumio volumio[1115]: info: Discovery: Getting this device information Mar 13 20:57:26 volumio volumio[1115]: info: CoreCommandRouter::volumioGetState Mar 13 20:57:26 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 13 20:57:26 volumio kernel: usb 1-1.1: USB disconnect, device number 3 Mar 13 20:57:26 volumio systemd[1]: media-92A816A5A81687BD.mount: Succeeded. Mar 13 20:57:26 volumio sudo[2358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda5 Mar 13 20:57:26 volumio volumio[1115]: 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.1/1-1.1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/usb-Mass_Storage_Device_116AC2101219-0:0-part1 /dev/disk/by-partuuid/f35b44c4-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.1/1-1.1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"26","ID_BUS":"usb","ID_INSTANCE":"0:0","ID_MODEL":"Storage_Device","ID_MODEL_ENC":"Storage\\x20Device\\x20\\x20","ID_MODEL_ID":"6116","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"1953523056","ID_PART_ENTRY_TYPE":"0xf","ID_PART_ENTRY_UUID":"f35b44c4-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"5a5a5a5a","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_1_0-scsi-0_0_0_0","ID_REVISION":"0220","ID_SERIAL":"Mass_Storage_Device_116AC2101219-0:0","ID_SERIAL_SHORT":"116AC2101219","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Mass","ID_VENDOR_ENC":"\\x20\\x20\\x20Mass\\x20","ID_VENDOR_ID":"14cd","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2456","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"3108266"} Mar 13 20:57:26 volumio volumio[1115]: error: Cannot associate FS Label, not mounting Mar 13 20:57:26 volumio sudo[2358]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 20:57:26 volumio volumio[1115]: 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.1/1-1.1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda5","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-Mass_Storage_Device_116AC2101219-0:0-part5 /dev/disk/by-uuid/92A816A5A81687BD /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.1:1.0-scsi-0:0:0:0-part5 /dev/disk/by-partuuid/f35b44c4-05","DEVNAME":"/dev/sda5","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.1/1-1.1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda5","DEVTYPE":"partition","DISKSEQ":"26","ID_BUS":"usb","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"92A816A5A81687BD","ID_FS_UUID_ENC":"92A816A5A81687BD","ID_INSTANCE":"0:0","ID_MODEL":"Storage_Device","ID_MODEL_ENC":"Storage\\x20Device\\x20\\x20","ID_MODEL_ID":"6116","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"5","ID_PART_ENTRY_OFFSET":"2176","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"1953522928","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"f35b44c4-05","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"f35b44c4","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_1_0-scsi-0_0_0_0","ID_REVISION":"0220","ID_SERIAL":"Mass_Storage_Device_116AC2101219-0:0","ID_SERIAL_SHORT":"116AC2101219","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Mass","ID_VENDOR_ENC":"\\x20\\x20\\x20Mass\\x20","ID_VENDOR_ID":"14cd","MAJOR":"8","MINOR":"5","PARTN":"5","SEQNUM":"2457","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"3149822"} Mar 13 20:57:26 volumio ntfs-3g[1182]: Unmounting /dev/sda5 () Mar 13 20:57:26 volumio sudo[2358]: pam_unix(sudo:session): session closed for user root Mar 13 20:57:26 volumio kernel: usb 1-1.1: new high-speed USB device number 4 using xhci_hcd Mar 13 20:57:27 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Mar 13 20:57:27 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Mar 13 20:57:27 volumio kernel: usb 1-1.1: new high-speed USB device number 5 using xhci_hcd Mar 13 20:57:28 volumio kernel: usb 1-1.1: New USB device found, idVendor=14cd, idProduct=6116, bcdDevice= 2.20 Mar 13 20:57:28 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Mar 13 20:57:28 volumio kernel: usb 1-1.1: Product: USB Mass Storage Device Mar 13 20:57:28 volumio kernel: usb 1-1.1: Manufacturer: Generic Mar 13 20:57:28 volumio kernel: usb 1-1.1: SerialNumber: 116AC2101219 Mar 13 20:57:28 volumio kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected Mar 13 20:57:28 volumio kernel: scsi host0: usb-storage 1-1.1:1.0 Mar 13 20:57:29 volumio kernel: scsi 0:0:0:0: Direct-Access Mass Storage Device PQ: 0 ANSI: 0 Mar 13 20:57:29 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Mar 13 20:57:29 volumio kernel: sd 0:0:0:0: [sda] 1953525166 512-byte logical blocks: (1.00 TB/932 GiB) Mar 13 20:57:29 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Mar 13 20:57:29 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 03 00 00 00 Mar 13 20:57:29 volumio kernel: sd 0:0:0:0: [sda] No Caching mode page found Mar 13 20:57:29 volumio kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through Mar 13 20:57:29 volumio kernel: sda: sda1 < sda5 > Mar 13 20:57:29 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Mar 13 20:57:29 volumio volumio[1115]: error: Cannot associate FS Label, not mounting Mar 13 20:57:29 volumio volumio[1115]: info: Mounting Device 92A816A5A81687BD Mar 13 20:57:29 volumio sudo[2375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda5 /mnt/USB/92A816A5A81687BD -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 13 20:57:29 volumio sudo[2375]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 20:57:30 volumio ntfs-3g[2378]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 13 20:57:30 volumio ntfs-3g[2378]: Mounted /dev/sda5 (Read-Write, label "", NTFS 3.1) Mar 13 20:57:30 volumio ntfs-3g[2378]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 13 20:57:30 volumio ntfs-3g[2378]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda5,blkdev,blksize=4096 Mar 13 20:57:30 volumio ntfs-3g[2378]: Global ownership and permissions enforced, configuration type 7 Mar 13 20:57:30 volumio sudo[2375]: pam_unix(sudo:session): session closed for user root Mar 13 20:57:30 volumio volumio[1115]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/92A816A5A81687BD Mar 13 20:57:31 volumio volumio[1115]: info: Scanning removed location : "USB/92A816A5A81687BD" Mar 13 20:57:31 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand status Mar 13 20:57:31 volumio volumio[1115]: info: Mar 13 20:57:31 volumio volumio[1115]: ---------------------------- MPD announces state update: update Mar 13 20:57:31 volumio volumio[1115]: info: ControllerMpd::getState Mar 13 20:57:31 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand status Mar 13 20:57:31 volumio volumio[1115]: info: sendMpdCommand status took 3 milliseconds Mar 13 20:57:31 volumio volumio[1115]: info: sendMpdCommand status took 2 milliseconds Mar 13 20:57:31 volumio volumio[1115]: verbose: ControllerMpd::parseState Mar 13 20:57:31 volumio volumio[1115]: info: Command Router : Notfying DB Updatetrue Mar 13 20:57:31 volumio volumio[1115]: verbose: ControllerMpd::parseState Mar 13 20:57:31 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 20:57:31 volumio volumio[1115]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 13 20:57:31 volumio volumio[1115]: verbose: ControllerMpd::parseTrackInfo Mar 13 20:57:31 volumio volumio[1115]: info: ControllerMpd::pushState Mar 13 20:57:31 volumio volumio[1115]: info: CoreCommandRouter::servicePushState Mar 13 20:57:31 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:57:31 volumio volumio[1115]: verbose: STATE SERVICE {"status":"play","position":0,"seek":21049,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"899 Kbps","isStreaming":false,"title":"Deceived Heart Again (Piano)","artist":"Umar Keyn","album":"Deceived Heart Again (Piano)","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-120.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D95f322cf345580259baf1947ce66da2a6cfce183ea98539af3fa44b5decb96c7%2Clid%3D1521%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e135d7%2F0%2F13481838%2Fe72cb0f8.184240243.12.127330314%2Fflac&ext=.flac","trackType":"flac"} Mar 13 20:57:31 volumio volumio[1115]: verbose: CURRENT POSITION 0 Mar 13 20:57:31 volumio volumio[1115]: info: CoreStateMachine::syncState stateService play Mar 13 20:57:31 volumio volumio[1115]: info: CoreStateMachine::syncState currentStatus play Mar 13 20:57:31 volumio volumio[1115]: info: Received an update from plugin. extracting info from payload Mar 13 20:57:31 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:57:31 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 20:57:31 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:57:31 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:57:31 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:57:31 volumio volumio[1115]: info: ------------------------------ 191ms Mar 13 20:57:31 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:57:31 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:57:31 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:57:31 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:57:31 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:57:31 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:57:33 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 13 20:57:33 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 13 20:57:33 volumio volumio[1115]: info: Discovery: Getting this device information Mar 13 20:57:33 volumio volumio[1115]: info: CoreCommandRouter::volumioGetState Mar 13 20:57:33 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 13 20:57:51 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand status Mar 13 20:57:51 volumio volumio[1115]: info: Mar 13 20:57:51 volumio volumio[1115]: ---------------------------- MPD announces state update: update Mar 13 20:57:51 volumio volumio[1115]: info: ControllerMpd::getState Mar 13 20:57:51 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand status Mar 13 20:57:51 volumio volumio[1115]: info: sendMpdCommand status took 2 milliseconds Mar 13 20:57:51 volumio volumio[1115]: info: sendMpdCommand status took 1 milliseconds Mar 13 20:57:51 volumio volumio[1115]: verbose: ControllerMpd::parseState Mar 13 20:57:51 volumio volumio[1115]: info: Command Router : Notfying DB Updatefalse Mar 13 20:57:51 volumio volumio[1115]: info: CoreCommandRouter::Close All Modals sent Mar 13 20:57:51 volumio volumio[1115]: verbose: ControllerMpd::parseState Mar 13 20:57:51 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 20:57:51 volumio volumio[1115]: info: sendMpdCommand playlistinfo took 17 milliseconds Mar 13 20:57:51 volumio volumio[1115]: verbose: ControllerMpd::parseTrackInfo Mar 13 20:57:51 volumio volumio[1115]: info: ControllerMpd::pushState Mar 13 20:57:51 volumio volumio[1115]: info: CoreCommandRouter::servicePushState Mar 13 20:57:51 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:57:51 volumio volumio[1115]: verbose: STATE SERVICE {"status":"play","position":0,"seek":27455,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1082 Kbps","isStreaming":false,"title":"Deceived Heart Again (Piano)","artist":"Umar Keyn","album":"Deceived Heart Again (Piano)","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-120.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D95f322cf345580259baf1947ce66da2a6cfce183ea98539af3fa44b5decb96c7%2Clid%3D1521%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e135d7%2F0%2F13481838%2Fe72cb0f8.184240243.12.127330314%2Fflac&ext=.flac","trackType":"flac"} Mar 13 20:57:51 volumio volumio[1115]: verbose: CURRENT POSITION 0 Mar 13 20:57:51 volumio volumio[1115]: info: CoreStateMachine::syncState stateService play Mar 13 20:57:51 volumio volumio[1115]: info: CoreStateMachine::syncState currentStatus play Mar 13 20:57:51 volumio volumio[1115]: info: Received an update from plugin. extracting info from payload Mar 13 20:57:51 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:57:51 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 20:57:51 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:57:51 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:57:51 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:57:51 volumio volumio[1115]: info: ------------------------------ 149ms Mar 13 20:57:51 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:57:51 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:57:51 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:57:51 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:57:51 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:57:51 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:57:53 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 13 20:57:53 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 13 20:57:53 volumio volumio[1115]: info: Discovery: Getting this device information Mar 13 20:57:53 volumio volumio[1115]: info: CoreCommandRouter::volumioGetState Mar 13 20:57:53 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 13 20:57:56 volumio volumio[1115]: info: CoreCommandRouter::volumioPause Mar 13 20:57:56 volumio volumio[1115]: info: CoreStateMachine::pause Mar 13 20:57:56 volumio volumio[1115]: info: CoreStateMachine::stPlaybackTimer Mar 13 20:57:56 volumio volumio[1115]: info: CoreStateMachine::servicePause Mar 13 20:57:56 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:57:56 volumio volumio[1115]: info: CoreCommandRouter::servicePause Mar 13 20:57:56 volumio volumio[1115]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 13 20:57:56 volumio volumio[1115]: info: ControllerMpd::pause Mar 13 20:57:56 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand pause Mar 13 20:57:56 volumio volumio[1115]: info: Mar 13 20:57:56 volumio volumio[1115]: ---------------------------- MPD announces state update: player Mar 13 20:57:56 volumio volumio[1115]: info: sendMpdCommand pause took 2 milliseconds Mar 13 20:57:56 volumio volumio[1115]: info: ControllerMpd::getState Mar 13 20:57:56 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand status Mar 13 20:57:56 volumio volumio[1115]: info: sendMpdCommand status took 1 milliseconds Mar 13 20:57:56 volumio volumio[1115]: verbose: ControllerMpd::parseState Mar 13 20:57:56 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 20:57:56 volumio volumio[1115]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 13 20:57:56 volumio volumio[1115]: verbose: ControllerMpd::parseTrackInfo Mar 13 20:57:56 volumio volumio[1115]: info: ControllerMpd::pushState Mar 13 20:57:56 volumio volumio[1115]: info: CoreCommandRouter::servicePushState Mar 13 20:57:56 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:57:56 volumio volumio[1115]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":28576,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1034 Kbps","isStreaming":false,"title":"Deceived Heart Again (Piano)","artist":"Umar Keyn","album":"Deceived Heart Again (Piano)","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-120.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D95f322cf345580259baf1947ce66da2a6cfce183ea98539af3fa44b5decb96c7%2Clid%3D1521%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e135d7%2F0%2F13481838%2Fe72cb0f8.184240243.12.127330314%2Fflac&ext=.flac","trackType":"flac"} Mar 13 20:57:56 volumio volumio[1115]: verbose: CURRENT POSITION 0 Mar 13 20:57:56 volumio volumio[1115]: info: CoreStateMachine::syncState stateService pause Mar 13 20:57:56 volumio volumio[1115]: info: CoreStateMachine::syncState currentStatus pause Mar 13 20:57:56 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:57:56 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 20:57:56 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:57:56 volumio volumio[1115]: info: CoreStateMachine::stPlaybackTimer Mar 13 20:57:56 volumio volumio[1115]: info: ------------------------------ 25ms Mar 13 20:57:56 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:57:56 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:57:56 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:57:56 volumio volumio[1115]: info: touch_display: Setting screensaver timeout to 3600 seconds. Mar 13 20:57:57 volumio volumio[1115]: info: peppy_screensaver: Start PeppyMeter Mar 13 20:57:58 volumio volumio[1115]: info: CoreCommandRouter::volumioNext Mar 13 20:57:58 volumio volumio[1115]: info: CoreStateMachine::next Mar 13 20:57:58 volumio volumio[1115]: info: ControllerMpd::next Mar 13 20:57:58 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand next Mar 13 20:57:58 volumio volumio[1115]: info: Mar 13 20:57:58 volumio volumio[1115]: ---------------------------- MPD announces state update: player Mar 13 20:57:58 volumio volumio[1115]: info: sendMpdCommand next took 3 milliseconds Mar 13 20:57:58 volumio volumio[1115]: info: ControllerMpd::getState Mar 13 20:57:58 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand status Mar 13 20:57:58 volumio volumio[1115]: info: sendMpdCommand status took 1 milliseconds Mar 13 20:57:58 volumio volumio[1115]: verbose: ControllerMpd::parseState Mar 13 20:57:58 volumio volumio[1115]: info: ControllerMpd::pushState Mar 13 20:57:58 volumio volumio[1115]: info: CoreCommandRouter::servicePushState Mar 13 20:57:58 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:57:58 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 20:57:58 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:57:58 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:57:58 volumio volumio[1115]: 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} Mar 13 20:57:58 volumio volumio[1115]: verbose: CURRENT POSITION 0 Mar 13 20:57:58 volumio volumio[1115]: info: CoreStateMachine::syncState stateService stop Mar 13 20:57:58 volumio volumio[1115]: info: CoreStateMachine::syncState currentStatus pause Mar 13 20:57:58 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:57:58 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:57:58 volumio volumio[1115]: info: ------------------------------ 35ms Mar 13 20:57:58 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:57:58 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:57:58 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:57:58 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:57:58 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:57:58 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:58:00 volumio volumio[1115]: info: CoreCommandRouter::volumioNext Mar 13 20:58:00 volumio volumio[1115]: info: CoreStateMachine::next Mar 13 20:58:00 volumio volumio[1115]: info: ControllerMpd::next Mar 13 20:58:00 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand next Mar 13 20:58:02 volumio volumio[1115]: info: CoreCommandRouter::volumioPlay Mar 13 20:58:02 volumio volumio[1115]: info: CoreStateMachine::play index undefined Mar 13 20:58:02 volumio volumio[1115]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 20:58:02 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:58:02 volumio volumio[1115]: info: CoreStateMachine::startPlaybackTimer Mar 13 20:58:02 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:58:02 volumio volumio[1115]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 13 20:58:02 volumio volumio[1115]: info: ControllerMpd::resume Mar 13 20:58:02 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand play Mar 13 20:58:02 volumio volumio[1115]: info: sendMpdCommand play took 1 milliseconds Mar 13 20:58:02 volumio volumio[1115]: info: CoreCommandRouter::volumioNext Mar 13 20:58:02 volumio volumio[1115]: info: CoreStateMachine::next Mar 13 20:58:02 volumio volumio[1115]: info: ControllerMpd::next Mar 13 20:58:02 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand next Mar 13 20:58:02 volumio volumio[1115]: info: Mar 13 20:58:02 volumio volumio[1115]: ---------------------------- MPD announces state update: player Mar 13 20:58:02 volumio volumio[1115]: info: sendMpdCommand next took 1 milliseconds Mar 13 20:58:02 volumio volumio[1115]: info: ControllerMpd::getState Mar 13 20:58:02 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand status Mar 13 20:58:03 volumio volumio[1115]: info: sendMpdCommand status took 1 milliseconds Mar 13 20:58:03 volumio volumio[1115]: verbose: ControllerMpd::parseState Mar 13 20:58:03 volumio volumio[1115]: info: ControllerMpd::pushState Mar 13 20:58:03 volumio volumio[1115]: info: CoreCommandRouter::servicePushState Mar 13 20:58:03 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:58:03 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 20:58:03 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:58:03 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:58:03 volumio volumio[1115]: 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} Mar 13 20:58:03 volumio volumio[1115]: verbose: CURRENT POSITION 0 Mar 13 20:58:03 volumio volumio[1115]: info: CoreStateMachine::syncState stateService stop Mar 13 20:58:03 volumio volumio[1115]: info: CoreStateMachine::syncState currentStatus pause Mar 13 20:58:03 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:58:03 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:58:03 volumio volumio[1115]: info: ------------------------------ 28ms Mar 13 20:58:03 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:58:03 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:58:03 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:58:03 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:58:03 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:58:03 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:58:05 volumio volumio[1115]: info: CoreCommandRouter::volumioPlay Mar 13 20:58:05 volumio volumio[1115]: info: CoreStateMachine::play index undefined Mar 13 20:58:05 volumio volumio[1115]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 20:58:05 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:58:05 volumio volumio[1115]: info: CoreStateMachine::startPlaybackTimer Mar 13 20:58:05 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:58:05 volumio volumio[1115]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 13 20:58:05 volumio volumio[1115]: info: ControllerMpd::resume Mar 13 20:58:05 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand play Mar 13 20:58:05 volumio volumio[1115]: info: sendMpdCommand play took 6 milliseconds Mar 13 20:58:06 volumio volumio[1115]: info: CoreCommandRouter::volumioNext Mar 13 20:58:06 volumio volumio[1115]: info: CoreStateMachine::next Mar 13 20:58:06 volumio volumio[1115]: info: ControllerMpd::next Mar 13 20:58:06 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand next Mar 13 20:58:06 volumio volumio[1115]: info: Mar 13 20:58:06 volumio volumio[1115]: ---------------------------- MPD announces state update: player Mar 13 20:58:06 volumio volumio[1115]: info: sendMpdCommand next took 2 milliseconds Mar 13 20:58:06 volumio volumio[1115]: info: ControllerMpd::getState Mar 13 20:58:06 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand status Mar 13 20:58:06 volumio volumio[1115]: info: sendMpdCommand status took 3 milliseconds Mar 13 20:58:06 volumio volumio[1115]: verbose: ControllerMpd::parseState Mar 13 20:58:06 volumio volumio[1115]: info: ControllerMpd::pushState Mar 13 20:58:06 volumio volumio[1115]: info: CoreCommandRouter::servicePushState Mar 13 20:58:06 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:58:06 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 20:58:06 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:58:06 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:58:06 volumio volumio[1115]: 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} Mar 13 20:58:06 volumio volumio[1115]: verbose: CURRENT POSITION 0 Mar 13 20:58:06 volumio volumio[1115]: info: CoreStateMachine::syncState stateService stop Mar 13 20:58:06 volumio volumio[1115]: info: CoreStateMachine::syncState currentStatus pause Mar 13 20:58:06 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:58:06 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:58:06 volumio volumio[1115]: info: ------------------------------ 30ms Mar 13 20:58:06 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:58:06 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:58:06 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:58:06 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:58:06 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:58:06 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:58:08 volumio volumio[1115]: info: CoreCommandRouter::volumioPlay Mar 13 20:58:08 volumio volumio[1115]: info: CoreStateMachine::play index undefined Mar 13 20:58:08 volumio volumio[1115]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 20:58:08 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:58:08 volumio volumio[1115]: info: CoreStateMachine::startPlaybackTimer Mar 13 20:58:08 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:58:08 volumio volumio[1115]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 13 20:58:08 volumio volumio[1115]: info: ControllerMpd::resume Mar 13 20:58:08 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand play Mar 13 20:58:08 volumio volumio[1115]: info: sendMpdCommand play took 1 milliseconds Mar 13 20:58:11 volumio volumio[1115]: info: Mar 13 20:58:11 volumio volumio[1115]: ---------------------------- MPD announces state update: player Mar 13 20:58:11 volumio volumio[1115]: info: ControllerMpd::getState Mar 13 20:58:11 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand status Mar 13 20:58:11 volumio volumio[1115]: info: Mar 13 20:58:11 volumio volumio[1115]: ---------------------------- MPD announces state update: player Mar 13 20:58:11 volumio volumio[1115]: info: sendMpdCommand status took 5 milliseconds Mar 13 20:58:11 volumio volumio[1115]: info: ControllerMpd::getState Mar 13 20:58:11 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand status Mar 13 20:58:11 volumio volumio[1115]: verbose: ControllerMpd::parseState Mar 13 20:58:11 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 20:58:11 volumio volumio[1115]: info: sendMpdCommand status took 1 milliseconds Mar 13 20:58:11 volumio volumio[1115]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 13 20:58:11 volumio volumio[1115]: verbose: ControllerMpd::parseState Mar 13 20:58:11 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 20:58:11 volumio volumio[1115]: verbose: ControllerMpd::parseTrackInfo Mar 13 20:58:11 volumio volumio[1115]: info: ControllerMpd::pushState Mar 13 20:58:11 volumio volumio[1115]: info: CoreCommandRouter::servicePushState Mar 13 20:58:11 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:58:11 volumio volumio[1115]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Deceived Heart Again (Piano)","artist":"Umar Keyn","album":"Deceived Heart Again (Piano)","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-120.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D95f322cf345580259baf1947ce66da2a6cfce183ea98539af3fa44b5decb96c7%2Clid%3D1521%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e135d7%2F0%2F13481838%2Fe72cb0f8.184240243.12.127330314%2Fflac&ext=.flac","trackType":"flac"} Mar 13 20:58:11 volumio volumio[1115]: verbose: CURRENT POSITION 0 Mar 13 20:58:11 volumio volumio[1115]: info: CoreStateMachine::syncState stateService play Mar 13 20:58:11 volumio volumio[1115]: info: CoreStateMachine::syncState currentStatus pause Mar 13 20:58:11 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:58:11 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 20:58:11 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:58:11 volumio volumio[1115]: info: ------------------------------ 23ms Mar 13 20:58:11 volumio volumio[1115]: info: sendMpdCommand playlistinfo took 16 milliseconds Mar 13 20:58:11 volumio volumio[1115]: verbose: ControllerMpd::parseTrackInfo Mar 13 20:58:11 volumio volumio[1115]: info: ControllerMpd::pushState Mar 13 20:58:11 volumio volumio[1115]: info: CoreCommandRouter::servicePushState Mar 13 20:58:11 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:58:11 volumio volumio[1115]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"220 Kbps","isStreaming":false,"title":"Deceived Heart Again (Piano)","artist":"Umar Keyn","album":"Deceived Heart Again (Piano)","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-120.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D95f322cf345580259baf1947ce66da2a6cfce183ea98539af3fa44b5decb96c7%2Clid%3D1521%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e135d7%2F0%2F13481838%2Fe72cb0f8.184240243.12.127330314%2Fflac&ext=.flac","trackType":"flac"} Mar 13 20:58:11 volumio volumio[1115]: verbose: CURRENT POSITION 0 Mar 13 20:58:11 volumio volumio[1115]: info: CoreStateMachine::syncState stateService play Mar 13 20:58:11 volumio volumio[1115]: info: CoreStateMachine::syncState currentStatus play Mar 13 20:58:11 volumio volumio[1115]: info: Received an update from plugin. extracting info from payload Mar 13 20:58:11 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:58:11 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 20:58:11 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:58:11 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:58:11 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:58:11 volumio volumio[1115]: info: ------------------------------ 56ms Mar 13 20:58:11 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:58:11 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:58:11 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:58:11 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:58:11 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:58:11 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:58:11 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:58:11 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:58:11 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:58:11 volumio volumio[1115]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 13 20:58:12 volumio volumio[1115]: info: CoreCommandRouter::volumioNext Mar 13 20:58:12 volumio volumio[1115]: info: CoreStateMachine::next Mar 13 20:58:12 volumio volumio[1115]: info: ControllerMpd::next Mar 13 20:58:12 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand next Mar 13 20:58:12 volumio volumio[1115]: info: Mar 13 20:58:12 volumio volumio[1115]: ---------------------------- MPD announces state update: player Mar 13 20:58:12 volumio volumio[1115]: info: sendMpdCommand next took 21 milliseconds Mar 13 20:58:12 volumio volumio[1115]: info: ControllerMpd::getState Mar 13 20:58:12 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand status Mar 13 20:58:12 volumio volumio[1115]: info: sendMpdCommand status took 1 milliseconds Mar 13 20:58:12 volumio volumio[1115]: verbose: ControllerMpd::parseState Mar 13 20:58:12 volumio volumio[1115]: info: ControllerMpd::pushState Mar 13 20:58:12 volumio volumio[1115]: info: CoreCommandRouter::servicePushState Mar 13 20:58:12 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:58:12 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 20:58:12 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:58:12 volumio volumio[1115]: info: CorePlayQueue::getTrack 0 Mar 13 20:58:12 volumio volumio[1115]: 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} Mar 13 20:58:12 volumio volumio[1115]: verbose: CURRENT POSITION 0 Mar 13 20:58:12 volumio volumio[1115]: info: CoreStateMachine::syncState stateService stop Mar 13 20:58:12 volumio volumio[1115]: info: CoreStateMachine::syncState currentStatus play Mar 13 20:58:12 volumio volumio[1115]: info: CoreStateMachine::play index undefined Mar 13 20:58:12 volumio volumio[1115]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 20:58:12 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:58:12 volumio volumio[1115]: info: CorePlayQueue::getTrack 1 Mar 13 20:58:12 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 20:58:12 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:58:12 volumio volumio[1115]: info: CorePlayQueue::getTrack 1 Mar 13 20:58:12 volumio volumio[1115]: info: CoreStateMachine::startPlaybackTimer Mar 13 20:58:12 volumio volumio[1115]: info: CorePlayQueue::getTrack 1 Mar 13 20:58:12 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand stop Mar 13 20:58:12 volumio volumio[1115]: info: ------------------------------ 34ms Mar 13 20:58:12 volumio volumio[1115]: info: CoreStateMachine::pushState Mar 13 20:58:12 volumio volumio[1115]: info: CorePlayQueue::getTrack 1 Mar 13 20:58:12 volumio volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 20:58:12 volumio volumio[1115]: info: CoreCommandRouter::volumioPushState Mar 13 20:58:12 volumio volumio[1115]: info: sendMpdCommand stop took 25 milliseconds Mar 13 20:58:12 volumio volumio[1115]: verbose: ControllerMpd::sendMpdCommand clear Mar 13 20:58:12 volumio volumio[1115]: info: CoreCommandRouter::volumioGetQueue Mar 13 20:58:12 volumio volumio[1115]: info: CoreStateMachine::getQueue Mar 13 20:58:12 volumio volumio[1115]: info: CorePlayQueue::getQueue Mar 13 20:58:12 volumio volumio[1115]: info: Mar 13 20:58:12 volumio volumio[1115]: ---------------------------- MPD announces system playlist update Mar 13 20:58:12 volumio volumio[1115]: info: Ignoring MPD Status Update Mar 13 20:58:12 volumio volumio[1115]: info: sendMpdCommand clear took 57 milliseconds Mar 13 20:58:12 volumio volumio[1115]: error: updateQueue error: null Mar 13 20:58:12 volumio volumio[1115]: info: ------------------------------ 16ms Mar 13 20:58:12 volumio volumio[1115]: info: touch_display: Setting screensaver timeout to 3600 seconds. Mar 13 20:58:13 volumio volumio[1115]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 13 20:58:13 volumio volumio[1115]: Error: read ECONNRESET Mar 13 20:58:13 volumio volumio[1115]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Mar 13 20:58:13 volumio volumio[1115]: errno: -104, Mar 13 20:58:13 volumio volumio[1115]: code: 'ECONNRESET', Mar 13 20:58:13 volumio volumio[1115]: syscall: 'read' Mar 13 20:58:13 volumio volumio[1115]: } Mar 13 20:58:13 volumio volumio[1115]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 13 20:58:13 volumio sudo[2627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-13 20:57 Mar 13 20:58:13 volumio sudo[2627]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"