-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Fri 2025-09-05 18:43:55 CEST. -- Sep 05 18:42:04 volumiomusica kernel: usb 1-1.2: USB disconnect, device number 4 Sep 05 18:42:04 volumiomusica volumio[1127]: info: Partition removed: {"syspath":"/sys/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-Kingston_DT_101_G2_001CC0EC33B0FC30F70C2D46-0:0-part1 /dev/disk/by-label/ESD-USB /dev/disk/by-partuuid/53c635a0-01 /dev/disk/by-uuid/1CF4-F811 /dev/disk/by-path/platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_LABEL":"ESD-USB","ID_FS_LABEL_ENC":"ESD-USB","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"1CF4-F811","ID_FS_UUID_ENC":"1CF4-F811","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"DT_101_G2","ID_MODEL_ENC":"DT\\x20101\\x20G2\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"1642","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":"15128576","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"53c635a0-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"53c635a0","ID_PATH":"platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-ff540000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"Kingston_DT_101_G2_001CC0EC33B0FC30F70C2D46-0:0","ID_SERIAL_SHORT":"001CC0EC33B0FC30F70C2D46","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Kingston","ID_VENDOR_ENC":"Kingston","ID_VENDOR_ID":"0951","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"3062","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"302226752"} Sep 05 18:42:04 volumiomusica sudo[2794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1 Sep 05 18:42:04 volumiomusica sudo[2794]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 18:42:04 volumiomusica systemd[1]: media-ESD\x2dUSB.mount: Succeeded. Sep 05 18:42:04 volumiomusica sudo[2794]: pam_unix(sudo:session): session closed for user root Sep 05 18:42:08 volumiomusica volumio[1127]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/ESD-USB Sep 05 18:42:09 volumiomusica volumio[1127]: info: Scanning removed location : "USB/ESD-USB" Sep 05 18:42:09 volumiomusica volumio[1127]: verbose: ControllerMpd::sendMpdCommand status Sep 05 18:42:09 volumiomusica volumio[1127]: info: Sep 05 18:42:09 volumiomusica volumio[1127]: ---------------------------- MPD announces state update: update Sep 05 18:42:09 volumiomusica volumio[1127]: info: ControllerMpd::getState Sep 05 18:42:09 volumiomusica volumio[1127]: verbose: ControllerMpd::sendMpdCommand status Sep 05 18:42:09 volumiomusica volumio[1127]: info: sendMpdCommand status took 6 milliseconds Sep 05 18:42:09 volumiomusica volumio[1127]: info: sendMpdCommand status took 2 milliseconds Sep 05 18:42:09 volumiomusica volumio[1127]: verbose: ControllerMpd::parseState Sep 05 18:42:09 volumiomusica volumio[1127]: info: Command Router : Notfying DB Updatetrue Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreCommandRouter::Close All Modals sent Sep 05 18:42:09 volumiomusica volumio[1127]: verbose: ControllerMpd::parseState Sep 05 18:42:09 volumiomusica volumio[1127]: info: ControllerMpd::pushState Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreCommandRouter::servicePushState Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:42:09 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:42:09 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:09 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:09 volumiomusica volumio[1127]: 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 05 18:42:09 volumiomusica volumio[1127]: verbose: CURRENT POSITION 0 Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreStateMachine::syncState stateService stop Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreStateMachine::syncState currentStatus stop Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:42:09 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:42:09 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:09 volumiomusica volumio[1127]: info: No code Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:42:09 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:42:09 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:42:09 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:09 volumiomusica volumio[1127]: info: ------------------------------ 82ms Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:42:09 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:42:10 volumiomusica volumio[1127]: info: MPD Database updated - AlbumList cache refreshed Sep 05 18:42:10 volumiomusica volumio[1127]: info: Sep 05 18:42:10 volumiomusica volumio[1127]: ---------------------------- MPD announces state update: database Sep 05 18:42:10 volumiomusica volumio[1127]: verbose: ControllerMpd::sendMpdCommand status Sep 05 18:42:10 volumiomusica volumio[1127]: info: Sep 05 18:42:10 volumiomusica volumio[1127]: ---------------------------- MPD announces state update: update Sep 05 18:42:10 volumiomusica volumio[1127]: info: ControllerMpd::getState Sep 05 18:42:10 volumiomusica volumio[1127]: verbose: ControllerMpd::sendMpdCommand status Sep 05 18:42:10 volumiomusica volumio[1127]: info: ControllerMpd::getState Sep 05 18:42:10 volumiomusica volumio[1127]: verbose: ControllerMpd::sendMpdCommand status Sep 05 18:42:14 volumiomusica volumio[1127]: info: sendMpdCommand status took 4845 milliseconds Sep 05 18:42:14 volumiomusica volumio[1127]: info: sendMpdCommand status took 4848 milliseconds Sep 05 18:42:14 volumiomusica volumio[1127]: info: sendMpdCommand status took 4849 milliseconds Sep 05 18:42:14 volumiomusica volumio[1127]: verbose: ControllerMpd::parseState Sep 05 18:42:14 volumiomusica volumio[1127]: info: Command Router : Notfying DB Updatefalse Sep 05 18:42:14 volumiomusica volumio[1127]: info: CoreCommandRouter::Close All Modals sent Sep 05 18:42:14 volumiomusica volumio[1127]: verbose: ControllerMpd::parseState Sep 05 18:42:14 volumiomusica volumio[1127]: verbose: ControllerMpd::parseState Sep 05 18:42:14 volumiomusica volumio[1127]: info: ControllerMpd::pushState Sep 05 18:42:14 volumiomusica volumio[1127]: info: CoreCommandRouter::servicePushState Sep 05 18:42:14 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:42:14 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:14 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:42:14 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:42:14 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:14 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:14 volumiomusica volumio[1127]: 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 05 18:42:14 volumiomusica volumio[1127]: verbose: CURRENT POSITION 0 Sep 05 18:42:14 volumiomusica volumio[1127]: info: CoreStateMachine::syncState stateService stop Sep 05 18:42:14 volumiomusica volumio[1127]: info: CoreStateMachine::syncState currentStatus stop Sep 05 18:42:14 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:42:14 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:14 volumiomusica volumio[1127]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 18:42:14 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:42:14 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:42:14 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:14 volumiomusica volumio[1127]: info: No code Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:15 volumiomusica volumio[1127]: info: ControllerMpd::pushState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreCommandRouter::servicePushState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:15 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:15 volumiomusica volumio[1127]: 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 05 18:42:15 volumiomusica volumio[1127]: verbose: CURRENT POSITION 0 Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreStateMachine::syncState stateService stop Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreStateMachine::syncState currentStatus stop Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:15 volumiomusica volumio[1127]: info: No code Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:42:15 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:42:15 volumiomusica volumio[1127]: info: ------------------------------ 4966ms Sep 05 18:42:15 volumiomusica volumio[1127]: info: ------------------------------ 4967ms Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:42:15 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:42:18 volumiomusica go-librespot[1533]: time="2025-09-05T18:42:18+02:00" level=trace msg="sent dealer ping" Sep 05 18:42:18 volumiomusica go-librespot[1533]: time="2025-09-05T18:42:18+02:00" level=trace msg="received dealer pong" Sep 05 18:42:47 volumiomusica go-librespot[1533]: time="2025-09-05T18:42:47+02:00" level=trace msg="received accesspoint ping" Sep 05 18:42:47 volumiomusica go-librespot[1533]: time="2025-09-05T18:42:47+02:00" level=trace msg="received accesspoint pong ack" Sep 05 18:42:48 volumiomusica go-librespot[1533]: time="2025-09-05T18:42:48+02:00" level=trace msg="sent dealer ping" Sep 05 18:42:48 volumiomusica go-librespot[1533]: time="2025-09-05T18:42:48+02:00" level=trace msg="received dealer pong" Sep 05 18:43:00 volumiomusica volumio[1127]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 18:43:00 volumiomusica volumio[1127]: info: CURURI: music-library/USB/UDISK_20 Sep 05 18:43:00 volumiomusica volumio[1127]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 05 18:43:00 volumiomusica volumio[1127]: info: Preload queue cleared Sep 05 18:43:09 volumiomusica volumio[1127]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 18:43:09 volumiomusica volumio[1127]: info: CURURI: music-library/USB Sep 05 18:43:09 volumiomusica volumio[1127]: info: Preload queue cleared Sep 05 18:43:18 volumiomusica go-librespot[1533]: time="2025-09-05T18:43:18+02:00" level=trace msg="sent dealer ping" Sep 05 18:43:18 volumiomusica go-librespot[1533]: time="2025-09-05T18:43:18+02:00" level=trace msg="received dealer pong" Sep 05 18:43:31 volumiomusica kernel: usb 1-1.2: new high-speed USB device number 5 using dwc2 Sep 05 18:43:31 volumiomusica kernel: usb 1-1.2: New USB device found, idVendor=0951, idProduct=1642 Sep 05 18:43:31 volumiomusica kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Sep 05 18:43:31 volumiomusica kernel: usb 1-1.2: Product: DT 101 G2 Sep 05 18:43:31 volumiomusica kernel: usb 1-1.2: Manufacturer: Kingston Sep 05 18:43:31 volumiomusica kernel: usb 1-1.2: SerialNumber: 001CC0EC33B0FC30F70C2D46 Sep 05 18:43:31 volumiomusica kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Sep 05 18:43:31 volumiomusica kernel: scsi host2: usb-storage 1-1.2:1.0 Sep 05 18:43:32 volumiomusica kernel: scsi 2:0:0:0: Direct-Access Kingston DT 101 G2 1.00 PQ: 0 ANSI: 4 Sep 05 18:43:32 volumiomusica kernel: sd 2:0:0:0: [sdb] 15131636 512-byte logical blocks: (7.75 GB/7.21 GiB) Sep 05 18:43:32 volumiomusica kernel: sd 2:0:0:0: [sdb] Write Protect is off Sep 05 18:43:32 volumiomusica kernel: sd 2:0:0:0: [sdb] Mode Sense: 45 00 00 00 Sep 05 18:43:32 volumiomusica kernel: sd 2:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Sep 05 18:43:32 volumiomusica kernel: sdb: sdb1 Sep 05 18:43:32 volumiomusica kernel: sd 2:0:0:0: [sdb] Attached SCSI removable disk Sep 05 18:43:32 volumiomusica volumio[1127]: info: Mounting Device ESD-USB Sep 05 18:43:32 volumiomusica sudo[3042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/ESD-USB -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Sep 05 18:43:32 volumiomusica sudo[3042]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 18:43:32 volumiomusica kernel: FAT-fs (sdb1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Sep 05 18:43:32 volumiomusica sudo[3042]: pam_unix(sudo:session): session closed for user root Sep 05 18:43:32 volumiomusica kernel: FAT-fs (sdb1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Sep 05 18:43:32 volumiomusica volumio[1127]: info: Scanning new location : "USB/ESD-USB" Sep 05 18:43:32 volumiomusica volumio[1127]: verbose: ControllerMpd::sendMpdCommand status Sep 05 18:43:32 volumiomusica volumio[1127]: info: Sep 05 18:43:32 volumiomusica volumio[1127]: ---------------------------- MPD announces state update: update Sep 05 18:43:32 volumiomusica volumio[1127]: info: ControllerMpd::getState Sep 05 18:43:32 volumiomusica volumio[1127]: verbose: ControllerMpd::sendMpdCommand status Sep 05 18:43:32 volumiomusica volumio[1127]: info: sendMpdCommand status took 5 milliseconds Sep 05 18:43:32 volumiomusica volumio[1127]: info: sendMpdCommand status took 2 milliseconds Sep 05 18:43:32 volumiomusica volumio[1127]: verbose: ControllerMpd::parseState Sep 05 18:43:32 volumiomusica volumio[1127]: info: Command Router : Notfying DB Updatetrue Sep 05 18:43:32 volumiomusica volumio[1127]: info: CoreCommandRouter::Close All Modals sent Sep 05 18:43:32 volumiomusica volumio[1127]: verbose: ControllerMpd::parseState Sep 05 18:43:32 volumiomusica volumio[1127]: info: ControllerMpd::pushState Sep 05 18:43:32 volumiomusica volumio[1127]: info: CoreCommandRouter::servicePushState Sep 05 18:43:32 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:43:32 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:32 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:43:32 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:43:32 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:32 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:32 volumiomusica volumio[1127]: 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 05 18:43:32 volumiomusica volumio[1127]: verbose: CURRENT POSITION 0 Sep 05 18:43:32 volumiomusica volumio[1127]: info: CoreStateMachine::syncState stateService stop Sep 05 18:43:32 volumiomusica volumio[1127]: info: CoreStateMachine::syncState currentStatus stop Sep 05 18:43:32 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:43:32 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:32 volumiomusica volumio[1127]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 18:43:32 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:43:33 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:43:33 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:33 volumiomusica volumio[1127]: info: No code Sep 05 18:43:33 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:43:33 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:33 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:43:33 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:43:33 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:33 volumiomusica volumio[1127]: info: ------------------------------ 88ms Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:43:33 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:43:37 volumiomusica volumio[1127]: info: MPD Database updated - AlbumList cache refreshed Sep 05 18:43:37 volumiomusica volumio[1127]: info: Sep 05 18:43:37 volumiomusica volumio[1127]: ---------------------------- MPD announces state update: database Sep 05 18:43:37 volumiomusica volumio[1127]: verbose: ControllerMpd::sendMpdCommand status Sep 05 18:43:37 volumiomusica volumio[1127]: info: Sep 05 18:43:37 volumiomusica volumio[1127]: ---------------------------- MPD announces state update: update Sep 05 18:43:37 volumiomusica volumio[1127]: info: ControllerMpd::getState Sep 05 18:43:37 volumiomusica volumio[1127]: verbose: ControllerMpd::sendMpdCommand status Sep 05 18:43:37 volumiomusica volumio[1127]: info: ControllerMpd::getState Sep 05 18:43:37 volumiomusica volumio[1127]: verbose: ControllerMpd::sendMpdCommand status Sep 05 18:43:42 volumiomusica volumio[1127]: info: sendMpdCommand status took 4889 milliseconds Sep 05 18:43:42 volumiomusica volumio[1127]: info: sendMpdCommand status took 4894 milliseconds Sep 05 18:43:42 volumiomusica volumio[1127]: info: sendMpdCommand status took 4894 milliseconds Sep 05 18:43:42 volumiomusica volumio[1127]: verbose: ControllerMpd::parseState Sep 05 18:43:42 volumiomusica volumio[1127]: info: Command Router : Notfying DB Updatefalse Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::Close All Modals sent Sep 05 18:43:42 volumiomusica volumio[1127]: verbose: ControllerMpd::parseState Sep 05 18:43:42 volumiomusica volumio[1127]: verbose: ControllerMpd::parseState Sep 05 18:43:42 volumiomusica volumio[1127]: info: ControllerMpd::pushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::servicePushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: 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 05 18:43:42 volumiomusica volumio[1127]: verbose: CURRENT POSITION 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreStateMachine::syncState stateService stop Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreStateMachine::syncState currentStatus stop Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: No code Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: ControllerMpd::pushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::servicePushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: 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 05 18:43:42 volumiomusica volumio[1127]: verbose: CURRENT POSITION 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreStateMachine::syncState stateService stop Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreStateMachine::syncState currentStatus stop Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: No code Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreStateMachine::pushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetState Sep 05 18:43:42 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:42 volumiomusica volumio[1127]: info: ------------------------------ 5020ms Sep 05 18:43:42 volumiomusica volumio[1127]: info: ------------------------------ 5021ms Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: SPOTIFY VOLUME 34 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: VOLUMIO VOLUME 35 Sep 05 18:43:42 volumiomusica volumio[1127]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 05 18:43:45 volumiomusica volumio[1127]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 18:43:45 volumiomusica volumio[1127]: info: CURURI: music-library/USB Sep 05 18:43:45 volumiomusica volumio[1127]: info: Preload queue cleared Sep 05 18:43:47 volumiomusica volumio[1127]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 18:43:47 volumiomusica volumio[1127]: info: CURURI: music-library/USB/ESD-USB Sep 05 18:43:47 volumiomusica volumio[1127]: info: Preload queue cleared Sep 05 18:43:47 volumiomusica volumio[1127]: info: Preloading song: music-library/USB/ESD-USB/Devo Live Lollapalooza.ogg Sep 05 18:43:47 volumiomusica volumio[1127]: info: Preloading song: music-library/USB/ESD-USB/Low - Live at Pitchfork Music Festival 2022 (Full Concert).flac Sep 05 18:43:47 volumiomusica volumio[1127]: info: Preloading song: music-library/USB/ESD-USB/LOW - NOX ORAE 2019 Full Live performance HD [TubeRipper.com].flac Sep 05 18:43:47 volumiomusica volumio[1127]: info: Exploding uri music-library/USB/ESD-USB/Devo Live Lollapalooza.ogg in service mpd Sep 05 18:43:47 volumiomusica volumio[1127]: info: ALBUMART /albumart?cacheid=154&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FDevo%20Live%20Lollapalooza.ogg&metadata=false Sep 05 18:43:47 volumiomusica volumio[1127]: info: URI /mnt/USB/ESD-USB/Devo Live Lollapalooza.ogg Sep 05 18:43:47 volumiomusica volumio[1127]: info: Exploding uri music-library/USB/ESD-USB/Low - Live at Pitchfork Music Festival 2022 (Full Concert).flac in service mpd Sep 05 18:43:47 volumiomusica volumio[1127]: info: ALBUMART /albumart?cacheid=154&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FLow%20-%20Live%20at%20Pitchfork%20Music%20Festival%202022%20(Full%20Concert).flac&metadata=false Sep 05 18:43:47 volumiomusica volumio[1127]: info: URI /mnt/USB/ESD-USB/Low - Live at Pitchfork Music Festival 2022 (Full Concert).flac Sep 05 18:43:47 volumiomusica volumio[1127]: info: Exploding uri music-library/USB/ESD-USB/LOW - NOX ORAE 2019 Full Live performance HD [TubeRipper.com].flac in service mpd Sep 05 18:43:47 volumiomusica volumio[1127]: info: ALBUMART /albumart?cacheid=154&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FLOW%20-%20NOX%20ORAE%202019%20Full%20Live%20performance%20HD%20%5BTubeRipper.com%5D.flac&metadata=false Sep 05 18:43:47 volumiomusica volumio[1127]: info: URI /mnt/USB/ESD-USB/LOW - NOX ORAE 2019 Full Live performance HD [TubeRipper.com].flac Sep 05 18:43:48 volumiomusica go-librespot[1533]: time="2025-09-05T18:43:48+02:00" level=trace msg="sent dealer ping" Sep 05 18:43:48 volumiomusica go-librespot[1533]: time="2025-09-05T18:43:48+02:00" level=trace msg="received dealer pong" Sep 05 18:43:54 volumiomusica volumio[1127]: info: Preload queue cleared Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::ClearQueue Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::stop Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 18:43:54 volumiomusica volumio[1127]: info: CorePlayQueue::clearPlayQueue Sep 05 18:43:54 volumiomusica volumio[1127]: info: CorePlayQueue::saveQueue Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushQueue Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::addQueueItems Sep 05 18:43:54 volumiomusica volumio[1127]: info: CorePlayQueue::addQueueItems Sep 05 18:43:54 volumiomusica volumio[1127]: info: Preload queue cleared Sep 05 18:43:54 volumiomusica volumio[1127]: info: Adding Item to queue: music-library/USB/ESD-USB/Devo Live Lollapalooza.ogg Sep 05 18:43:54 volumiomusica volumio[1127]: info: Using cached record of: music-library/USB/ESD-USB/Devo Live Lollapalooza.ogg Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPushQueue Sep 05 18:43:54 volumiomusica volumio[1127]: info: CorePlayQueue::saveQueue Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::updateTrackBlock Sep 05 18:43:54 volumiomusica volumio[1127]: info: CorePlayQueue::getTrackBlock Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioPlay Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::play index 0 Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::addQueueItems Sep 05 18:43:54 volumiomusica volumio[1127]: info: CorePlayQueue::addQueueItems Sep 05 18:43:54 volumiomusica volumio[1127]: info: Preload queue cleared Sep 05 18:43:54 volumiomusica volumio[1127]: info: Adding Item to queue: music-library/USB/ESD-USB/Low - Live at Pitchfork Music Festival 2022 (Full Concert).flac Sep 05 18:43:54 volumiomusica volumio[1127]: info: Using cached record of: music-library/USB/ESD-USB/Low - Live at Pitchfork Music Festival 2022 (Full Concert).flac Sep 05 18:43:54 volumiomusica volumio[1127]: info: Adding Item to queue: music-library/USB/ESD-USB/LOW - NOX ORAE 2019 Full Live performance HD [TubeRipper.com].flac Sep 05 18:43:54 volumiomusica volumio[1127]: info: Using cached record of: music-library/USB/ESD-USB/LOW - NOX ORAE 2019 Full Live performance HD [TubeRipper.com].flac Sep 05 18:43:54 volumiomusica volumio[1127]: info: Adding Item to queue: music-library/USB/ESD-USB/2022 Live At Pitchfork Music Festival 2022 [FLAC] Sep 05 18:43:54 volumiomusica volumio[1127]: info: Exploding uri music-library/USB/ESD-USB/2022 Live At Pitchfork Music Festival 2022 [FLAC] in service mpd Sep 05 18:43:54 volumiomusica volumio[1127]: info: Adding Item to queue: music-library/USB/ESD-USB/Low - Ones and Sixes.zip Sep 05 18:43:54 volumiomusica volumio[1127]: info: Exploding uri music-library/USB/ESD-USB/Low - Ones and Sixes.zip in service mpd Sep 05 18:43:54 volumiomusica volumio[1127]: info: Adding Item to queue: music-library/USB/ESD-USB/Low - The Invisible Way.zip Sep 05 18:43:54 volumiomusica volumio[1127]: info: Exploding uri music-library/USB/ESD-USB/Low - The Invisible Way.zip in service mpd Sep 05 18:43:54 volumiomusica volumio[1127]: info: Adding Item to queue: music-library/USB/ESD-USB/stick Sep 05 18:43:54 volumiomusica volumio[1127]: info: Exploding uri music-library/USB/ESD-USB/stick in service mpd Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::stop Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::play index undefined Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 18:43:54 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreStateMachine::startPlaybackTimer Sep 05 18:43:54 volumiomusica volumio[1127]: info: CorePlayQueue::getTrack 0 Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 18:43:54 volumiomusica volumio[1127]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 05 18:43:54 volumiomusica volumio[1127]: verbose: ControllerMpd::clearAddPlayTracks USB/ESD-USB/Devo Live Lollapalooza.ogg Sep 05 18:43:54 volumiomusica volumio[1127]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 18:43:54 volumiomusica volumio[1127]: info: ALBUMART /albumart?cacheid=154&web=Low/Live%20At%20Pitchfork%20Music%20Festival%202022/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2F2022%20Live%20At%20Pitchfork%20Music%20Festival%202022%20%5BFLAC%5D%2F01%20Live%20At%20Pitchfork%20Music%20Festival%202022.flac&metadata=false Sep 05 18:43:54 volumiomusica volumio[1127]: info: URI /mnt/USB/ESD-USB/2022 Live At Pitchfork Music Festival 2022 [FLAC]/01 Live At Pitchfork Music Festival 2022.flac Sep 05 18:43:54 volumiomusica volumio[1127]: info: ALBUMART /albumart?cacheid=154&web=Low/Ones%20and%20Sixes/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FLow%20-%20Ones%20and%20Sixes.zip&metadata=false Sep 05 18:43:54 volumiomusica volumio[1127]: info: URI /mnt/USB/ESD-USB/Low - Ones and Sixes.zip Sep 05 18:43:54 volumiomusica volumio[1127]: info: ALBUMART /albumart?cacheid=154&web=Low/Ones%20and%20Sixes/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FLow%20-%20Ones%20and%20Sixes.zip&metadata=false Sep 05 18:43:54 volumiomusica volumio[1127]: info: URI /mnt/USB/ESD-USB/Low - Ones and Sixes.zip Sep 05 18:43:54 volumiomusica volumio[1127]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 18:43:54 volumiomusica volumio[1127]: Error: Unable to resolve or reject the same promise twice Sep 05 18:43:54 volumiomusica volumio[1127]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Sep 05 18:43:54 volumiomusica volumio[1127]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21 Sep 05 18:43:54 volumiomusica volumio[1127]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Sep 05 18:43:54 volumiomusica volumio[1127]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Sep 05 18:43:54 volumiomusica volumio[1127]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Sep 05 18:43:54 volumiomusica volumio[1127]: at Socket.emit (events.js:400:28) Sep 05 18:43:54 volumiomusica volumio[1127]: at addChunk (internal/streams/readable.js:293:12) Sep 05 18:43:54 volumiomusica volumio[1127]: at readableAddChunk (internal/streams/readable.js:263:11) Sep 05 18:43:54 volumiomusica volumio[1127]: at Socket.Readable.push (internal/streams/readable.js:206:10) Sep 05 18:43:54 volumiomusica volumio[1127]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Sep 05 18:43:54 volumiomusica volumio[1127]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 18:43:55 volumiomusica sudo[3100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-05 18:42 Sep 05 18:43:55 volumiomusica sudo[3100]: 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="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:55:15 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="2f3686ade78abf3b92c180a0c5b20c6b"