-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Wed 2024-05-15 12:57:23 MSK. -- May 15 12:56:03 volumio volumio[863]: info: Preload queue cleared May 15 12:56:03 volumio volumio[863]: info: CoreCommandRouter::volumioReplaceandPlayItems May 15 12:56:03 volumio volumio[863]: info: CoreStateMachine::ClearQueue May 15 12:56:03 volumio volumio[863]: info: CoreStateMachine::stop May 15 12:56:03 volumio volumio[863]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:56:03 volumio volumio[863]: info: CorePlayQueue::clearPlayQueue May 15 12:56:03 volumio volumio[863]: info: CorePlayQueue::saveQueue May 15 12:56:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushQueue May 15 12:56:03 volumio volumio[863]: info: CoreStateMachine::addQueueItems May 15 12:56:03 volumio volumio[863]: info: CorePlayQueue::addQueueItems May 15 12:56:03 volumio volumio[863]: info: Preload queue cleared May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/01 - Bad Reputation.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/01 - Bad Reputation.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/02 - Light of Day.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/02 - Light of Day.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/03 - Do You Wanna Touch Me (Oh Yeah!).flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/03 - Do You Wanna Touch Me (Oh Yeah!).flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/04 - Roadrunner.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/04 - Roadrunner.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/05 - I Love Rock N Roll.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/05 - I Love Rock N Roll.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/06 - Victim of Circumstance.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/06 - Victim of Circumstance.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/07 - Everyday People.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/07 - Everyday People.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/08 - I Hate Myself For Loving You.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/08 - I Hate Myself For Loving You.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/09 - Crimson and Clover.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/09 - Crimson and Clover.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/10 - Fake Friends.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/10 - Fake Friends.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/11 - Make Believe.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/11 - Make Believe.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/12 - Cherry Bomb.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/12 - Cherry Bomb.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/13 - Little Liar.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/13 - Little Liar.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/14 - World of Denial.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/14 - World of Denial.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/15 - Love Is All Around.flac May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/15 - Love Is All Around.flac May 15 12:56:03 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/Fit to Be Tied Great Hits by Joan Jett and the Blackhearts.m3u May 15 12:56:03 volumio volumio[863]: info: Using cached record of: music-library/USB/ESD-USB/Temp/11. Joan Jett & The Blackhearts - Fit to Be Tied - 1997 {Blackheart Records • 4833752982}/Fit to Be Tied Great Hits by Joan Jett and the Blackhearts.m3u May 15 12:56:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushQueue May 15 12:56:03 volumio volumio[863]: info: CorePlayQueue::saveQueue May 15 12:56:03 volumio volumio[863]: info: CoreStateMachine::updateTrackBlock May 15 12:56:03 volumio volumio[863]: info: CorePlayQueue::getTrackBlock May 15 12:56:03 volumio volumio[863]: info: CoreCommandRouter::volumioPlay May 15 12:56:03 volumio volumio[863]: info: CoreStateMachine::play index 0 May 15 12:56:03 volumio volumio[863]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:56:03 volumio volumio[863]: info: CoreStateMachine::stop May 15 12:56:03 volumio volumio[863]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:56:03 volumio volumio[863]: info: CoreStateMachine::play index undefined May 15 12:56:03 volumio volumio[863]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:56:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:56:09 volumio volumio[863]: info: CoreCommandRouter::volumioPlay May 15 12:56:09 volumio volumio[863]: info: CoreStateMachine::play index undefined May 15 12:56:09 volumio volumio[863]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:56:09 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:56:25 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 15 12:56:25 volumio volumio[863]: info: CURURI: playlists May 15 12:56:25 volumio volumio[863]: info: Listing playlists May 15 12:56:25 volumio volumio[863]: info: Preload queue cleared May 15 12:56:28 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 15 12:56:28 volumio volumio[863]: info: CURURI: music-library May 15 12:56:28 volumio volumio[863]: info: Preload queue cleared May 15 12:56:29 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 15 12:56:29 volumio volumio[863]: info: CURURI: music-library/USB May 15 12:56:29 volumio volumio[863]: info: Preload queue cleared May 15 12:56:30 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 15 12:56:30 volumio volumio[863]: info: CURURI: music-library/USB/ESD-USB May 15 12:56:30 volumio volumio[863]: info: Preload queue cleared May 15 12:56:31 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 15 12:56:31 volumio volumio[863]: info: CURURI: music-library/USB/ESD-USB/Temp May 15 12:56:31 volumio volumio[863]: info: Preload queue cleared May 15 12:56:57 volumio kernel: usb 1-1.3: USB disconnect, device number 3 May 15 12:56:57 volumio volumio[863]: 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.3/1-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/1ec822bd-01 /dev/disk/by-id/usb-JetFlash_Transcend_16GB_O73G0DFH-0:0-part1 /dev/disk/by-label/ESD-USB /dev/disk/by-uuid/A2E2-9401 /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.3:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"27","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":"A2E2-9401","ID_FS_UUID_ENC":"A2E2-9401","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"Transcend_16GB","ID_MODEL_ENC":"Transcend\\x2016GB\\x20\\x20","ID_MODEL_ID":"1000","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"30529536","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"1ec822bd-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"1ec822bd","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_3_1_0-scsi-0_0_0_0","ID_REVISION":"8.07","ID_SERIAL":"JetFlash_Transcend_16GB_O73G0DFH-0:0","ID_SERIAL_SHORT":"O73G0DFH","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"JetFlash","ID_VENDOR_ENC":"JetFlash","ID_VENDOR_ID":"8564","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"1757","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"40345825"} May 15 12:56:57 volumio sudo[1539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 May 15 12:56:57 volumio sudo[1539]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 12:56:57 volumio sudo[1539]: pam_unix(sudo:session): session closed for user root May 15 12:56:57 volumio systemd[1]: media-ESD\x2dUSB.mount: Succeeded. May 15 12:57:01 volumio kernel: usb 1-1.3: new high-speed USB device number 4 using xhci_hcd May 15 12:57:01 volumio kernel: usb 1-1.3: New USB device found, idVendor=8564, idProduct=1000, bcdDevice= 1.00 May 15 12:57:01 volumio kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 May 15 12:57:01 volumio kernel: usb 1-1.3: Product: Mass Storage Device May 15 12:57:01 volumio kernel: usb 1-1.3: Manufacturer: JetFlash May 15 12:57:01 volumio kernel: usb 1-1.3: SerialNumber: O73G0DFH May 15 12:57:01 volumio kernel: usb-storage 1-1.3:1.0: USB Mass Storage device detected May 15 12:57:01 volumio kernel: scsi host0: usb-storage 1-1.3:1.0 May 15 12:57:01 volumio volumio[863]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/ESD-USB May 15 12:57:02 volumio kernel: scsi 0:0:0:0: Direct-Access JetFlash Transcend 16GB 8.07 PQ: 0 ANSI: 4 May 15 12:57:02 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 May 15 12:57:02 volumio kernel: sd 0:0:0:0: [sda] 30531584 512-byte logical blocks: (15.6 GB/14.6 GiB) May 15 12:57:02 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off May 15 12:57:02 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 23 00 00 00 May 15 12:57:02 volumio kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA May 15 12:57:02 volumio kernel: sda: sda1 May 15 12:57:02 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk May 15 12:57:02 volumio volumio[863]: info: Scanning removed location : "USB/ESD-USB" May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:02 volumio volumio[863]: info: May 15 12:57:02 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:02 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:02 volumio volumio[863]: info: May 15 12:57:02 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:02 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:02 volumio volumio[863]: info: May 15 12:57:02 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:02 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:02 volumio volumio[863]: info: May 15 12:57:02 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:02 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:02 volumio volumio[863]: info: sendMpdCommand status took 9 milliseconds May 15 12:57:02 volumio volumio[863]: info: sendMpdCommand status took 8 milliseconds May 15 12:57:02 volumio volumio[863]: info: sendMpdCommand status took 7 milliseconds May 15 12:57:02 volumio volumio[863]: info: sendMpdCommand status took 6 milliseconds May 15 12:57:02 volumio volumio[863]: info: sendMpdCommand status took 6 milliseconds May 15 12:57:02 volumio volumio[863]: info: sendMpdCommand status took 6 milliseconds May 15 12:57:02 volumio volumio[863]: info: sendMpdCommand status took 5 milliseconds May 15 12:57:02 volumio volumio[863]: info: sendMpdCommand status took 4 milliseconds May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:02 volumio volumio[863]: info: Command Router : Notfying DB Updatetrue May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:02 volumio volumio[863]: info: Command Router : Notfying DB Updatetrue May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:02 volumio volumio[863]: info: Command Router : Notfying DB Updatetrue May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:02 volumio volumio[863]: info: Command Router : Notfying DB Updatetrue May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:02 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:02 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:02 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:02 volumio volumio[863]: info: No code May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:02 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:02 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:02 volumio volumio[863]: info: No code May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:02 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:02 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:02 volumio volumio[863]: info: No code May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:02 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:02 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:02 volumio volumio[863]: info: No code May 15 12:57:02 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:02 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:02 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 247ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 245ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 243ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 243ms May 15 12:57:03 volumio volumio[863]: info: MPD Database updated - AlbumList cache refreshed May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: database May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: MPD Database updated - AlbumList cache refreshed May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: database May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: MPD Database updated - AlbumList cache refreshed May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: database May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: MPD Database updated - AlbumList cache refreshed May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: database May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 58 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 57 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 57 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 56 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 55 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 55 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 54 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 53 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 52 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 51 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 50 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 51 milliseconds May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: info: Command Router : Notfying DB Updatefalse May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: info: Command Router : Notfying DB Updatefalse May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: info: Command Router : Notfying DB Updatefalse May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: info: Command Router : Notfying DB Updatefalse May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 294ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 294ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 292ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 292ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 290ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 291ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 288ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 289ms May 15 12:57:03 volumio volumio[863]: info: Mounting Device ESD-USB May 15 12:57:03 volumio sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/ESD-USB -o noatime,dmask=0000,fmask=0000,iocharset=utf8 May 15 12:57:03 volumio sudo[1611]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 12:57:03 volumio sudo[1611]: pam_unix(sudo:session): session closed for user root May 15 12:57:03 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! May 15 12:57:03 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: Scanning new location : "USB/ESD-USB" May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: May 15 12:57:03 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 9 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 8 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 8 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 7 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 6 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 5 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 5 milliseconds May 15 12:57:03 volumio volumio[863]: info: sendMpdCommand status took 4 milliseconds May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: info: Command Router : Notfying DB Updatetrue May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: info: Command Router : Notfying DB Updatetrue May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: info: Command Router : Notfying DB Updatetrue May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: info: Command Router : Notfying DB Updatetrue May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:03 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:03 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: No code May 15 12:57:03 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:03 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:03 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 249ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 248ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 247ms May 15 12:57:03 volumio volumio[863]: info: ------------------------------ 245ms May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:03 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:04 volumio volumio[863]: info: MPD Database updated - AlbumList cache refreshed May 15 12:57:04 volumio volumio[863]: info: May 15 12:57:04 volumio volumio[863]: ---------------------------- MPD announces state update: database May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: May 15 12:57:04 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:04 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: MPD Database updated - AlbumList cache refreshed May 15 12:57:04 volumio volumio[863]: info: May 15 12:57:04 volumio volumio[863]: ---------------------------- MPD announces state update: database May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: May 15 12:57:04 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:04 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: MPD Database updated - AlbumList cache refreshed May 15 12:57:04 volumio volumio[863]: info: May 15 12:57:04 volumio volumio[863]: ---------------------------- MPD announces state update: database May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: May 15 12:57:04 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:04 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: MPD Database updated - AlbumList cache refreshed May 15 12:57:04 volumio volumio[863]: info: May 15 12:57:04 volumio volumio[863]: ---------------------------- MPD announces state update: database May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: May 15 12:57:04 volumio volumio[863]: ---------------------------- MPD announces state update: update May 15 12:57:04 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: ControllerMpd::getState May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::sendMpdCommand status May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: FusionDsp - May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 31 milliseconds May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 30 milliseconds May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 29 milliseconds May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 28 milliseconds May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 28 milliseconds May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 28 milliseconds May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 27 milliseconds May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 26 milliseconds May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 26 milliseconds May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 25 milliseconds May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 26 milliseconds May 15 12:57:04 volumio volumio[863]: info: sendMpdCommand status took 25 milliseconds May 15 12:57:04 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:04 volumio volumio[863]: info: Command Router : Notfying DB Updatefalse May 15 12:57:04 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:05 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:05 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:05 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:05 volumio volumio[863]: info: Command Router : Notfying DB Updatefalse May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:05 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:05 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:05 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:05 volumio volumio[863]: info: Command Router : Notfying DB Updatefalse May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:05 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:05 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:05 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:05 volumio volumio[863]: info: Command Router : Notfying DB Updatefalse May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent May 15 12:57:05 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:05 volumio volumio[863]: verbose: ControllerMpd::parseState May 15 12:57:05 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:05 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: No code May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:05 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: No code May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:05 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: No code May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:05 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: No code May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:05 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: No code May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:05 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: No code May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:05 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: No code May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: ControllerMpd::pushState May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::servicePushState May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 15 12:57:05 volumio volumio[863]: verbose: CURRENT POSITION 0 May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState stateService stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: No code May 15 12:57:05 volumio volumio[863]: info: CoreStateMachine::pushState May 15 12:57:05 volumio volumio[863]: info: CorePlayQueue::getTrack 0 May 15 12:57:05 volumio volumio[863]: info: CoreCommandRouter::volumioPushState May 15 12:57:05 volumio volumio[863]: info: ------------------------------ 306ms May 15 12:57:05 volumio volumio[863]: info: ------------------------------ 307ms May 15 12:57:05 volumio volumio[863]: info: ------------------------------ 305ms May 15 12:57:05 volumio volumio[863]: info: ------------------------------ 305ms May 15 12:57:05 volumio volumio[863]: info: ------------------------------ 304ms May 15 12:57:05 volumio volumio[863]: info: ------------------------------ 304ms May 15 12:57:05 volumio volumio[863]: info: ------------------------------ 303ms May 15 12:57:05 volumio volumio[863]: info: ------------------------------ 303ms May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:05 volumio volumio[863]: info: FusionDsp - Effects disabled May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: info: FusionDsp - May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:06 volumio volumio[863]: error: FusionDsp - WebSocket error: [object Object] May 15 12:57:17 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 15 12:57:17 volumio volumio[863]: info: CURURI: music-library/USB/ESD-USB/Temp May 15 12:57:17 volumio volumio[863]: info: Preload queue cleared May 15 12:57:22 volumio volumio[863]: info: Preload queue cleared May 15 12:57:22 volumio volumio[863]: info: CoreCommandRouter::volumioReplaceandPlayItems May 15 12:57:22 volumio volumio[863]: info: CoreStateMachine::ClearQueue May 15 12:57:22 volumio volumio[863]: info: CoreStateMachine::stop May 15 12:57:22 volumio volumio[863]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:57:22 volumio volumio[863]: info: CorePlayQueue::clearPlayQueue May 15 12:57:22 volumio volumio[863]: info: CorePlayQueue::saveQueue May 15 12:57:22 volumio volumio[863]: info: CoreCommandRouter::volumioPushQueue May 15 12:57:22 volumio volumio[863]: info: CoreStateMachine::addQueueItems May 15 12:57:22 volumio volumio[863]: info: CorePlayQueue::addQueueItems May 15 12:57:22 volumio volumio[863]: info: Preload queue cleared May 15 12:57:22 volumio volumio[863]: info: Adding Item to queue: music-library/USB/ESD-USB/Temp/(1985) Brothers In Arms [Vertigo, 824 499-2, West Germany] [02] [1st issue] May 15 12:57:22 volumio volumio[863]: info: Exploding uri music-library/USB/ESD-USB/Temp/(1985) Brothers In Arms [Vertigo, 824 499-2, West Germany] [02] [1st issue] in service mpd May 15 12:57:22 volumio volumio[863]: info: ALBUMART /albumart?cacheid=422&web=Dire%20Straits/Brothers%20In%20Arms/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FTemp%2F(1985)%20Brothers%20In%20Arms%20%5BVertigo%2C%20824%20499-2%2C%20West%20Germany%5D%20%5B02%5D%20%5B1st%20issue%5D%2FDire%20Straits%20-%20Brothers%20In%20Arms.cue&metadata=false May 15 12:57:22 volumio volumio[863]: info: URI /mnt/USB/ESD-USB/Temp/(1985) Brothers In Arms [Vertigo, 824 499-2, West Germany] [02] [1st issue]/Dire Straits - Brothers In Arms.cue May 15 12:57:22 volumio volumio[863]: info: ALBUMART /albumart?cacheid=422&web=Dire%20Straits/Brothers%20In%20Arms/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FTemp%2F(1985)%20Brothers%20In%20Arms%20%5BVertigo%2C%20824%20499-2%2C%20West%20Germany%5D%20%5B02%5D%20%5B1st%20issue%5D%2FDire%20Straits%20-%20Brothers%20In%20Arms.cue&metadata=false May 15 12:57:22 volumio volumio[863]: info: URI /mnt/USB/ESD-USB/Temp/(1985) Brothers In Arms [Vertigo, 824 499-2, West Germany] [02] [1st issue]/Dire Straits - Brothers In Arms.cue May 15 12:57:22 volumio volumio[863]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 12:57:22 volumio volumio[863]: Error: Unable to resolve or reject the same promise twice May 15 12:57:22 volumio volumio[863]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) May 15 12:57:22 volumio volumio[863]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 May 15 12:57:22 volumio volumio[863]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) May 15 12:57:22 volumio volumio[863]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) May 15 12:57:22 volumio volumio[863]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) May 15 12:57:22 volumio volumio[863]: at Socket.emit (events.js:315:20) May 15 12:57:22 volumio volumio[863]: at addChunk (internal/streams/readable.js:309:12) May 15 12:57:22 volumio volumio[863]: at readableAddChunk (internal/streams/readable.js:280:11) May 15 12:57:22 volumio volumio[863]: at Socket.Readable.push (internal/streams/readable.js:223:10) May 15 12:57:22 volumio volumio[863]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) May 15 12:57:22 volumio volumio[863]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 12:57:23 volumio sudo[1642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-15 12:56 May 15 12:57:23 volumio sudo[1642]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"