-- Logs begin at Sat 2024-11-23 08:34:52 UTC, end at Sat 2024-11-23 08:37:08 UTC. -- Nov 23 08:36:07 volumio volumio[1104]: info: VolumeController::SetAlsaVolume66 Nov 23 08:36:07 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:07 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 08:36:07 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:07 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:07 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:07 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:08 volumio volumio[1104]: info: VolumeController::SetAlsaVolume25 Nov 23 08:36:08 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:08 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 08:36:08 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:08 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:08 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:08 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:10 volumio volumio[1104]: info: VolumeController::SetAlsaVolume67 Nov 23 08:36:10 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:10 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 08:36:10 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:10 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:10 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:10 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:12 volumio volumio[1104]: info: VolumeController::SetAlsaVolume84 Nov 23 08:36:12 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:12 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 08:36:12 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:13 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:13 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:13 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:16 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:16 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:16 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:16 volumio ntpd[1502]: Soliciting pool server 202.118.1.81 Nov 23 08:36:17 volumio ntpd[1502]: Soliciting pool server 193.182.111.12 Nov 23 08:36:17 volumio ntpd[1502]: Soliciting pool server 202.112.29.82 Nov 23 08:36:18 volumio ntpd[1502]: Soliciting pool server 119.28.206.193 Nov 23 08:36:19 volumio ntpd[1502]: Soliciting pool server 202.112.31.197 Nov 23 08:36:19 volumio ntpd[1502]: Soliciting pool server 47.115.137.18 Nov 23 08:36:20 volumio ntpd[1502]: Soliciting pool server 193.182.111.143 Nov 23 08:36:21 volumio volumio[1104]: info: CoreCommandRouter::volumioGetState Nov 23 08:36:21 volumio ntpd[1502]: Soliciting pool server 2406:4440:0:105::2e:a Nov 23 08:36:27 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 23 08:36:27 volumio volumio[1104]: info: CURURI: music-library/USB/DEE2207AE2205953 Nov 23 08:36:27 volumio volumio[1104]: info: Preload queue cleared Nov 23 08:36:37 volumio kernel: usb 3-1.1: USB disconnect, device number 3 Nov 23 08:36:37 volumio volumio[1104]: info: Partition removed: {"syspath":"/sys/devices/pci0000:00/0000:00:12.0/usb3/3-1/3-1.1/3-1.1:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/DEE2207AE2205953 /dev/disk/by-id/usb-Realtek_RTL9210B-CG_012345678943-0:0-part1 /dev/disk/by-path/pci-0000:00:12.0-usb-0:1.1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/257b1508-01","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/pci0000:00/0000:00:12.0/usb3/3-1/3-1.1/3-1.1:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"2","ID_BUS":"usb","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"DEE2207AE2205953","ID_FS_UUID_ENC":"DEE2207AE2205953","ID_INSTANCE":"0:0","ID_MODEL":"RTL9210B-CG","ID_MODEL_ENC":"RTL9210B-CG\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"9210","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"3907026944","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"257b1508-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"257b1508","ID_PATH":"pci-0000:00:12.0-usb-0:1.1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"pci-0000_00_12_0-usb-0_1_1_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"Realtek_RTL9210B-CG_012345678943-0:0","ID_SERIAL_SHORT":"012345678943","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Realtek","ID_VENDOR_ENC":"Realtek\\x20","ID_VENDOR_ID":"0bda","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"3234","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"4487901"} Nov 23 08:36:37 volumio sudo[2572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1 Nov 23 08:36:37 volumio sudo[2572]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 08:36:37 volumio ntfs-3g[1586]: Unmounting /dev/sdb1 () Nov 23 08:36:37 volumio systemd[1]: media-DEE2207AE2205953.mount: Succeeded. Nov 23 08:36:37 volumio sudo[2572]: pam_unix(sudo:session): session closed for user root Nov 23 08:36:41 volumio volumio[1104]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/DEE2207AE2205953 Nov 23 08:36:42 volumio volumio[1104]: info: Scanning removed location : "USB/DEE2207AE2205953" Nov 23 08:36:42 volumio volumio[1104]: verbose: ControllerMpd::sendMpdCommand status Nov 23 08:36:42 volumio volumio[1104]: info: Nov 23 08:36:42 volumio volumio[1104]: ---------------------------- MPD announces state update: update Nov 23 08:36:42 volumio volumio[1104]: info: ControllerMpd::getState Nov 23 08:36:42 volumio volumio[1104]: verbose: ControllerMpd::sendMpdCommand status Nov 23 08:36:42 volumio volumio[1104]: info: sendMpdCommand status took 9 milliseconds Nov 23 08:36:42 volumio volumio[1104]: info: sendMpdCommand status took 7 milliseconds Nov 23 08:36:42 volumio volumio[1104]: verbose: ControllerMpd::parseState Nov 23 08:36:42 volumio volumio[1104]: info: Command Router : Notfying DB Updatetrue Nov 23 08:36:42 volumio volumio[1104]: verbose: ControllerMpd::parseState Nov 23 08:36:42 volumio volumio[1104]: info: ControllerMpd::pushState Nov 23 08:36:42 volumio volumio[1104]: info: CoreCommandRouter::servicePushState Nov 23 08:36:42 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:42 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:42 volumio volumio[1104]: info: CorePlayQueue::getTrack 1 Nov 23 08:36:42 volumio volumio[1104]: 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} Nov 23 08:36:42 volumio volumio[1104]: verbose: CURRENT POSITION 1 Nov 23 08:36:42 volumio volumio[1104]: info: CoreStateMachine::syncState stateService stop Nov 23 08:36:42 volumio volumio[1104]: info: CoreStateMachine::syncState currentStatus pause Nov 23 08:36:42 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:42 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 08:36:42 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:42 volumio volumio[1104]: info: ------------------------------ 72ms Nov 23 08:36:42 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:42 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:42 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:42 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:42 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:42 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:42 volumio volumio[1104]: info: MPD Database updated - AlbumList cache refreshed Nov 23 08:36:42 volumio volumio[1104]: info: Nov 23 08:36:42 volumio volumio[1104]: ---------------------------- MPD announces state update: database Nov 23 08:36:42 volumio volumio[1104]: verbose: ControllerMpd::sendMpdCommand status Nov 23 08:36:42 volumio volumio[1104]: info: Nov 23 08:36:42 volumio volumio[1104]: ---------------------------- MPD announces state update: update Nov 23 08:36:42 volumio volumio[1104]: info: ControllerMpd::getState Nov 23 08:36:42 volumio volumio[1104]: verbose: ControllerMpd::sendMpdCommand status Nov 23 08:36:42 volumio volumio[1104]: info: ControllerMpd::getState Nov 23 08:36:42 volumio volumio[1104]: verbose: ControllerMpd::sendMpdCommand status Nov 23 08:36:43 volumio volumio[1104]: info: sendMpdCommand status took 717 milliseconds Nov 23 08:36:43 volumio volumio[1104]: info: sendMpdCommand status took 716 milliseconds Nov 23 08:36:43 volumio volumio[1104]: info: sendMpdCommand status took 716 milliseconds Nov 23 08:36:43 volumio volumio[1104]: verbose: ControllerMpd::parseState Nov 23 08:36:43 volumio volumio[1104]: info: Command Router : Notfying DB Updatefalse Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::Close All Modals sent Nov 23 08:36:43 volumio volumio[1104]: verbose: ControllerMpd::parseState Nov 23 08:36:43 volumio volumio[1104]: verbose: ControllerMpd::parseState Nov 23 08:36:43 volumio volumio[1104]: info: ControllerMpd::pushState Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::servicePushState Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:43 volumio volumio[1104]: info: CorePlayQueue::getTrack 1 Nov 23 08:36:43 volumio volumio[1104]: 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} Nov 23 08:36:43 volumio volumio[1104]: verbose: CURRENT POSITION 1 Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::syncState stateService stop Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::syncState currentStatus pause Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:43 volumio volumio[1104]: info: ControllerMpd::pushState Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::servicePushState Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:43 volumio volumio[1104]: info: CorePlayQueue::getTrack 1 Nov 23 08:36:43 volumio volumio[1104]: 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} Nov 23 08:36:43 volumio volumio[1104]: verbose: CURRENT POSITION 1 Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::syncState stateService stop Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::syncState currentStatus pause Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:43 volumio volumio[1104]: info: ------------------------------ 787ms Nov 23 08:36:43 volumio volumio[1104]: info: ------------------------------ 786ms Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:43 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:43 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:43 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:43 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:43 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:43 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:45 volumio kernel: usb 3-1.1: new high-speed USB device number 9 using ehci-pci Nov 23 08:36:45 volumio kernel: usb 3-1.1: New USB device found, idVendor=0bda, idProduct=9210, bcdDevice=f0.01 Nov 23 08:36:45 volumio kernel: usb 3-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Nov 23 08:36:45 volumio kernel: usb 3-1.1: Product: RTL9210B-CG Nov 23 08:36:45 volumio kernel: usb 3-1.1: Manufacturer: Realtek Nov 23 08:36:45 volumio kernel: usb 3-1.1: SerialNumber: 012345678943 Nov 23 08:36:45 volumio kernel: usb-storage 3-1.1:1.0: USB Mass Storage device detected Nov 23 08:36:45 volumio kernel: scsi host1: usb-storage 3-1.1:1.0 Nov 23 08:36:46 volumio kernel: scsi 1:0:0:0: Direct-Access Realtek RTL9210B-CG 1.00 PQ: 0 ANSI: 6 Nov 23 08:36:46 volumio kernel: sd 1:0:0:0: Attached scsi generic sg1 type 0 Nov 23 08:36:46 volumio kernel: sd 1:0:0:0: [sdb] 3907029168 512-byte logical blocks: (2.00 TB/1.82 TiB) Nov 23 08:36:46 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off Nov 23 08:36:46 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 37 00 00 08 Nov 23 08:36:46 volumio kernel: sd 1:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Nov 23 08:36:46 volumio kernel: sdb: sdb1 Nov 23 08:36:46 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI disk Nov 23 08:36:47 volumio volumio[1104]: info: Mounting Device DEE2207AE2205953 Nov 23 08:36:47 volumio sudo[2657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/DEE2207AE2205953 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 23 08:36:47 volumio sudo[2657]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 08:36:49 volumio ntfs-3g[2687]: Version 2017.3.23AR.3 integrated FUSE 28 Nov 23 08:36:49 volumio ntfs-3g[2687]: Mounted /dev/sdb1 (Read-Write, label "", NTFS 3.1) Nov 23 08:36:49 volumio ntfs-3g[2687]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 23 08:36:49 volumio ntfs-3g[2687]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096 Nov 23 08:36:49 volumio ntfs-3g[2687]: Global ownership and permissions enforced, configuration type 7 Nov 23 08:36:49 volumio sudo[2657]: pam_unix(sudo:session): session closed for user root Nov 23 08:36:49 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 23 08:36:49 volumio volumio[1104]: Upnp client error: Error: This socket has been ended by the other party Nov 23 08:36:49 volumio volumio[1104]: info: Scanning new location : "USB/DEE2207AE2205953" Nov 23 08:36:49 volumio volumio[1104]: verbose: ControllerMpd::sendMpdCommand status Nov 23 08:36:49 volumio volumio[1104]: info: Nov 23 08:36:49 volumio volumio[1104]: ---------------------------- MPD announces state update: update Nov 23 08:36:49 volumio volumio[1104]: info: ControllerMpd::getState Nov 23 08:36:49 volumio volumio[1104]: verbose: ControllerMpd::sendMpdCommand status Nov 23 08:36:49 volumio volumio[1104]: info: sendMpdCommand status took 8 milliseconds Nov 23 08:36:49 volumio volumio[1104]: verbose: ControllerMpd::parseState Nov 23 08:36:50 volumio volumio[1104]: info: Command Router : Notfying DB Updatetrue Nov 23 08:36:50 volumio volumio[1104]: info: CoreCommandRouter::Close All Modals sent Nov 23 08:36:50 volumio volumio[1104]: info: Preload queue cleared Nov 23 08:36:50 volumio volumio[1104]: info: sendMpdCommand status took 51 milliseconds Nov 23 08:36:50 volumio volumio[1104]: verbose: ControllerMpd::parseState Nov 23 08:36:50 volumio volumio[1104]: info: ControllerMpd::pushState Nov 23 08:36:50 volumio volumio[1104]: info: CoreCommandRouter::servicePushState Nov 23 08:36:50 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:50 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:50 volumio volumio[1104]: info: CorePlayQueue::getTrack 1 Nov 23 08:36:50 volumio volumio[1104]: 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} Nov 23 08:36:50 volumio volumio[1104]: verbose: CURRENT POSITION 1 Nov 23 08:36:50 volumio volumio[1104]: info: CoreStateMachine::syncState stateService stop Nov 23 08:36:50 volumio volumio[1104]: info: CoreStateMachine::syncState currentStatus pause Nov 23 08:36:50 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:50 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 08:36:50 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:50 volumio volumio[1104]: info: ------------------------------ 78ms Nov 23 08:36:50 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:50 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:50 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:50 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:50 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:50 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:54 volumio volumio[1104]: info: MPD Database updated - AlbumList cache refreshed Nov 23 08:36:54 volumio volumio[1104]: info: Nov 23 08:36:54 volumio volumio[1104]: ---------------------------- MPD announces state update: database Nov 23 08:36:54 volumio volumio[1104]: verbose: ControllerMpd::sendMpdCommand status Nov 23 08:36:54 volumio volumio[1104]: info: Nov 23 08:36:54 volumio volumio[1104]: ---------------------------- MPD announces state update: update Nov 23 08:36:54 volumio volumio[1104]: info: ControllerMpd::getState Nov 23 08:36:54 volumio volumio[1104]: verbose: ControllerMpd::sendMpdCommand status Nov 23 08:36:54 volumio volumio[1104]: info: ControllerMpd::getState Nov 23 08:36:54 volumio volumio[1104]: verbose: ControllerMpd::sendMpdCommand status Nov 23 08:36:55 volumio volumio[1104]: info: sendMpdCommand status took 568 milliseconds Nov 23 08:36:55 volumio volumio[1104]: info: sendMpdCommand status took 569 milliseconds Nov 23 08:36:55 volumio volumio[1104]: info: sendMpdCommand status took 568 milliseconds Nov 23 08:36:55 volumio volumio[1104]: verbose: ControllerMpd::parseState Nov 23 08:36:55 volumio volumio[1104]: info: Command Router : Notfying DB Updatefalse Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::Close All Modals sent Nov 23 08:36:55 volumio volumio[1104]: verbose: ControllerMpd::parseState Nov 23 08:36:55 volumio volumio[1104]: verbose: ControllerMpd::parseState Nov 23 08:36:55 volumio volumio[1104]: info: ControllerMpd::pushState Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::servicePushState Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:55 volumio volumio[1104]: info: CorePlayQueue::getTrack 1 Nov 23 08:36:55 volumio volumio[1104]: 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} Nov 23 08:36:55 volumio volumio[1104]: verbose: CURRENT POSITION 1 Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::syncState stateService stop Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::syncState currentStatus pause Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:55 volumio volumio[1104]: info: ControllerMpd::pushState Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::servicePushState Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:55 volumio volumio[1104]: info: CorePlayQueue::getTrack 1 Nov 23 08:36:55 volumio volumio[1104]: 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} Nov 23 08:36:55 volumio volumio[1104]: verbose: CURRENT POSITION 1 Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::syncState stateService stop Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::syncState currentStatus pause Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::pushState Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::volumioPushState Nov 23 08:36:55 volumio volumio[1104]: info: ------------------------------ 622ms Nov 23 08:36:55 volumio volumio[1104]: info: ------------------------------ 622ms Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:55 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:55 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:55 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:36:55 volumio volumio[1104]: info: CoreCommandRouter::volumioGetQueue Nov 23 08:36:55 volumio volumio[1104]: info: CoreStateMachine::getQueue Nov 23 08:36:55 volumio volumio[1104]: info: CorePlayQueue::getQueue Nov 23 08:37:06 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 23 08:37:07 volumio volumio[1104]: info: Preload queue cleared Nov 23 08:37:08 volumio volumio[1104]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 23 08:37:08 volumio volumio[1104]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 08:37:08 volumio volumio[1104]: TypeError: Cannot read property 'duration' of undefined Nov 23 08:37:08 volumio volumio[1104]: at parseItem (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:216:32) Nov 23 08:37:08 volumio volumio[1104]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:128:40 Nov 23 08:37:08 volumio volumio[1104]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Nov 23 08:37:08 volumio volumio[1104]: at Parser.emit (events.js:400:28) Nov 23 08:37:08 volumio volumio[1104]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Nov 23 08:37:08 volumio volumio[1104]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Nov 23 08:37:08 volumio volumio[1104]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Nov 23 08:37:08 volumio volumio[1104]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Nov 23 08:37:08 volumio volumio[1104]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Nov 23 08:37:08 volumio volumio[1104]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Nov 23 08:37:08 volumio volumio[1104]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Nov 23 08:37:08 volumio volumio[1104]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Nov 23 08:37:08 volumio volumio[1104]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Nov 23 08:37:08 volumio volumio[1104]: at IncomingMessage.emit (events.js:412:35) Nov 23 08:37:08 volumio volumio[1104]: at endReadableNT (internal/streams/readable.js:1333:12) Nov 23 08:37:08 volumio volumio[1104]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Nov 23 08:37:08 volumio volumio[1104]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 08:37:08 volumio sudo[2876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-23 08:36 Nov 23 08:37:08 volumio sudo[2876]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"