-- Logs begin at Fri 2024-07-19 19:15:58 IST, end at Fri 2024-07-19 19:48:15 IST. -- Jul 19 19:47:01 volumio volumio[997]: info: Preload queue cleared Jul 19 19:47:01 volumio volumio[997]: info: Preloading song: mnt/USB/3832-6361/song HD/Alai-Payuthey-Kalyani-Menon-Harini-Neyveli-Ramalakshmi.m4a Jul 19 19:47:01 volumio volumio[997]: info: Exploding uri mnt/USB/3832-6361/song HD/Alai-Payuthey-Kalyani-Menon-Harini-Neyveli-Ramalakshmi.m4a in service mpd Jul 19 19:47:01 volumio volumio[997]: error: scanFolder - failure to stat '/mnt/USB/3832-6361/song HD/Alai-Payuthey-Kalyani-Menon-Harini-Neyveli-Ramalakshmi.m4a' Jul 19 19:47:05 volumio volumio[997]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Jul 19 19:47:05 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 19 19:47:05 volumio volumio[997]: info: CURURI: music-library Jul 19 19:47:05 volumio volumio[997]: error: Failed LSINFO: null Jul 19 19:47:05 volumio volumio[997]: info: Preload queue cleared Jul 19 19:47:08 volumio volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-USB3.0_Super_Speed_DD564198838B0-0:0-part1 /dev/disk/by-partuuid/f8633955-ff25-472b-8ca4-c1a5da753036 /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partlabel/Microsoft\\x20reserved\\x20partition","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"26","ID_BUS":"usb","ID_INSTANCE":"0:0","ID_MODEL":"Super_Speed","ID_MODEL_ENC":"Super\\x20Speed\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"0562","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"Microsoft\\x20reserved\\x20partition","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"34","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"32734","ID_PART_ENTRY_TYPE":"e3c9e316-0b5c-4db8-817d-f92df00215ae","ID_PART_ENTRY_UUID":"f8633955-ff25-472b-8ca4-c1a5da753036","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"af918845-b5eb-4b67-89a1-a3c468c9420e","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"3202","ID_SERIAL":"USB3.0_Super_Speed_DD564198838B0-0:0","ID_SERIAL_SHORT":"DD564198838B0","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB3.0","ID_VENDOR_ENC":"USB3.0\\x20\\x20","ID_VENDOR_ID":"152d","MAJOR":"8","MINOR":"1","PARTN":"1","PARTNAME":"Microsoft reserved partition","SEQNUM":"2364","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"3594524"} Jul 19 19:47:08 volumio volumio[997]: error: Cannot associate FS Label, not mounting Jul 19 19:47:08 volumio volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/66C421A0C4217409 /dev/disk/by-label/New\\x20Volume /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part2 /dev/disk/by-partuuid/f41b17d3-56e2-4bb3-a900-c6e2eb3b5a52 /dev/disk/by-partlabel/Basic\\x20data\\x20partition /dev/disk/by-id/usb-USB3.0_Super_Speed_DD564198838B0-0:0-part2","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"26","ID_BUS":"usb","ID_FS_LABEL":"New_Volume","ID_FS_LABEL_ENC":"New\\x20Volume","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"66C421A0C4217409","ID_FS_UUID_ENC":"66C421A0C4217409","ID_INSTANCE":"0:0","ID_MODEL":"Super_Speed","ID_MODEL_ENC":"Super\\x20Speed\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"0562","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"Basic\\x20data\\x20partition","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"32768","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"1953488896","ID_PART_ENTRY_TYPE":"ebd0a0a2-b9e5-4433-87c0-68b6b72699c7","ID_PART_ENTRY_UUID":"f41b17d3-56e2-4bb3-a900-c6e2eb3b5a52","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"af918845-b5eb-4b67-89a1-a3c468c9420e","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"3202","ID_SERIAL":"USB3.0_Super_Speed_DD564198838B0-0:0","ID_SERIAL_SHORT":"DD564198838B0","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB3.0","ID_VENDOR_ENC":"USB3.0\\x20\\x20","ID_VENDOR_ID":"152d","MAJOR":"8","MINOR":"2","PARTN":"2","PARTNAME":"Basic data partition","SEQNUM":"2365","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"3669512"} Jul 19 19:47:08 volumio kernel: usb 2-1: USB disconnect, device number 2 Jul 19 19:47:08 volumio sudo[2496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda2 Jul 19 19:47:08 volumio sudo[2496]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:08 volumio ntfs-3g[1061]: Unmounting /dev/sda2 (New Volume) Jul 19 19:47:08 volumio ntfs-3g[1061]: Failed to sync device /dev/sda2: Input/output error Jul 19 19:47:08 volumio ntfs-3g[1061]: Failed to close volume /dev/sda2: Input/output error Jul 19 19:47:08 volumio sudo[2496]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:08 volumio systemd[1]: media-New_Volume.mount: Succeeded. Jul 19 19:47:08 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Jul 19 19:47:09 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK Jul 19 19:47:12 volumio volumio[997]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/New_Volume Jul 19 19:47:13 volumio volumio[997]: info: Scanning removed location : "USB/New_Volume" Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: Jul 19 19:47:13 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: Jul 19 19:47:13 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: Jul 19 19:47:13 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: Jul 19 19:47:13 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: Jul 19 19:47:13 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand status took 6 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand status took 5 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand status took 5 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand status took 4 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand status took 5 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand status took 4 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand status took 4 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand status took 3 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand status took 3 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand status took 2 milliseconds Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:13 volumio volumio[997]: info: Command Router : Notfying DB Updatetrue Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:13 volumio volumio[997]: info: Command Router : Notfying DB Updatetrue Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:13 volumio volumio[997]: info: Command Router : Notfying DB Updatetrue Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:13 volumio volumio[997]: info: Command Router : Notfying DB Updatetrue Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:13 volumio volumio[997]: info: Command Router : Notfying DB Updatetrue Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: Jul 19 19:47:13 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand playlistinfo took 128 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand playlistinfo took 104 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand playlistinfo took 80 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand playlistinfo took 58 milliseconds Jul 19 19:47:13 volumio volumio[997]: info: sendMpdCommand playlistinfo took 34 milliseconds Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:13 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:13 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49474,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:13 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:13 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:13 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:13 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49474,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:13 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:13 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:13 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:13 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49474,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:13 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:13 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:13 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:13 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49474,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:13 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:13 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:13 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:13 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49474,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:13 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:13 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:13 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:13 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:13 volumio volumio[997]: info: ------------------------------ 252ms Jul 19 19:47:13 volumio volumio[997]: info: ------------------------------ 251ms Jul 19 19:47:13 volumio volumio[997]: info: ------------------------------ 251ms Jul 19 19:47:13 volumio volumio[997]: info: ------------------------------ 250ms Jul 19 19:47:13 volumio volumio[997]: info: ------------------------------ 249ms Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: Jul 19 19:47:13 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: Jul 19 19:47:13 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: Jul 19 19:47:13 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: Jul 19 19:47:13 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:13 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:13 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:13 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:13 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:13 volumio sudo[2523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:13 volumio sudo[2523]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:13 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:13 volumio sudo[2526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:13 volumio sudo[2526]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:13 volumio sudo[2523]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:13 volumio sudo[2526]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:13 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:13 volumio sudo[2529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:13 volumio sudo[2529]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:13 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2532]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio sudo[2529]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2532]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2535]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2535]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2538]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2538]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2541]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio sudo[2541]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2544]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2544]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2547]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio sudo[2547]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2550]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand status took 377 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand status took 377 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand status took 303 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand status took 302 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand status took 302 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand status took 301 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand status took 301 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand status took 300 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand status took 300 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand status took 299 milliseconds Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:14 volumio sudo[2550]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio volumio[997]: info: Command Router : Notfying DB Updatefalse Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:14 volumio volumio[997]: info: Command Router : Notfying DB Updatefalse Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:14 volumio volumio[997]: info: Command Router : Notfying DB Updatefalse Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:14 volumio volumio[997]: info: Command Router : Notfying DB Updatefalse Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:14 volumio volumio[997]: info: Command Router : Notfying DB Updatefalse Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand playlistinfo took 138 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand playlistinfo took 115 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand playlistinfo took 92 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand playlistinfo took 68 milliseconds Jul 19 19:47:14 volumio volumio[997]: info: sendMpdCommand playlistinfo took 44 milliseconds Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:14 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:14 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:14 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:14 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49600,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:14 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:14 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:14 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:14 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:14 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49725,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:14 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:14 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:14 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:14 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:14 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49725,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:14 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:14 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:14 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:14 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:14 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49725,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:14 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:14 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:14 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:14 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:14 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49725,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:14 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:14 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:14 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:14 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:14 volumio volumio[997]: info: ------------------------------ 617ms Jul 19 19:47:14 volumio volumio[997]: info: ------------------------------ 543ms Jul 19 19:47:14 volumio volumio[997]: info: ------------------------------ 542ms Jul 19 19:47:14 volumio volumio[997]: info: ------------------------------ 541ms Jul 19 19:47:14 volumio volumio[997]: info: ------------------------------ 540ms Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2566]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2566]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2569]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2569]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2569]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2572]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2572]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2575]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2575]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2578]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2578]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2581]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2581]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2584]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2584]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2587]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:14 volumio sudo[2590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2590]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio sudo[2587]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:14 volumio sudo[2590]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio sudo[2593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:14 volumio sudo[2593]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:14 volumio sudo[2593]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:14 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:17 volumio kernel: usb 2-2: new SuperSpeed USB device number 3 using xhci_hcd Jul 19 19:47:17 volumio kernel: usb 2-2: New USB device found, idVendor=152d, idProduct=0562, bcdDevice=32.02 Jul 19 19:47:17 volumio kernel: usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jul 19 19:47:17 volumio kernel: usb 2-2: Product: USB3.0 Super Speed Jul 19 19:47:17 volumio kernel: usb 2-2: Manufacturer: USB3.0 Super Speed Jul 19 19:47:17 volumio kernel: usb 2-2: SerialNumber: DD564198838B0 Jul 19 19:47:17 volumio kernel: scsi host0: uas Jul 19 19:47:17 volumio kernel: scsi 0:0:0:0: Direct-Access USB3.0 Super Speed 3202 PQ: 0 ANSI: 6 Jul 19 19:47:17 volumio kernel: sd 0:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Jul 19 19:47:17 volumio kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Jul 19 19:47:17 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Jul 19 19:47:17 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 53 00 00 08 Jul 19 19:47:17 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Jul 19 19:47:17 volumio kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jul 19 19:47:17 volumio kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes Jul 19 19:47:17 volumio kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes) Jul 19 19:47:17 volumio kernel: sda: sda1 sda2 Jul 19 19:47:17 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Jul 19 19:47:17 volumio volumio[997]: error: Cannot associate FS Label, not mounting Jul 19 19:47:17 volumio volumio[997]: info: Mounting Device New_Volume Jul 19 19:47:17 volumio sudo[2654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/New_Volume -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jul 19 19:47:17 volumio sudo[2654]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:18 volumio ntfs-3g[2657]: Version 2017.3.23AR.3 integrated FUSE 28 Jul 19 19:47:18 volumio ntfs-3g[2657]: Mounted /dev/sda2 (Read-Write, label "New Volume", NTFS 3.1) Jul 19 19:47:18 volumio ntfs-3g[2657]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Jul 19 19:47:18 volumio ntfs-3g[2657]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 Jul 19 19:47:18 volumio ntfs-3g[2657]: Global ownership and permissions enforced, configuration type 7 Jul 19 19:47:18 volumio sudo[2654]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:18 volumio volumio[997]: info: Scanning new location : "USB/New_Volume" Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:18 volumio volumio[997]: info: Jul 19 19:47:18 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:18 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:18 volumio volumio[997]: info: Jul 19 19:47:18 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:18 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:18 volumio volumio[997]: info: Jul 19 19:47:18 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:18 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:18 volumio volumio[997]: info: Jul 19 19:47:18 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:18 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:18 volumio volumio[997]: info: Jul 19 19:47:18 volumio volumio[997]: ---------------------------- MPD announces state update: update Jul 19 19:47:18 volumio volumio[997]: info: ControllerMpd::getState Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand status Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand status took 6 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand status took 5 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand status took 5 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand status took 4 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand status took 4 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand status took 3 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand status took 4 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand status took 3 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand status took 3 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand status took 2 milliseconds Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:18 volumio volumio[997]: info: Command Router : Notfying DB Updatetrue Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:18 volumio volumio[997]: info: Command Router : Notfying DB Updatetrue Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:18 volumio volumio[997]: info: Command Router : Notfying DB Updatetrue Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:18 volumio volumio[997]: info: Command Router : Notfying DB Updatetrue Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:18 volumio volumio[997]: info: Command Router : Notfying DB Updatetrue Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseState Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand playlistinfo took 132 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand playlistinfo took 106 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand playlistinfo took 81 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand playlistinfo took 57 milliseconds Jul 19 19:47:18 volumio volumio[997]: info: sendMpdCommand playlistinfo took 33 milliseconds Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:18 volumio volumio[997]: verbose: ControllerMpd::parseTrackInfo Jul 19 19:47:18 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:18 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:18 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":54102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:18 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:18 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:18 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:18 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:18 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":54102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:18 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:18 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:18 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:18 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:18 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":54102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:18 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:18 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:18 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:18 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:18 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":54102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:18 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:18 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:18 volumio volumio[997]: info: ControllerMpd::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::servicePushState Jul 19 19:47:18 volumio volumio[997]: info: CorePlayQueue::getTrack 0 Jul 19 19:47:18 volumio volumio[997]: verbose: STATE SERVICE {"status":"play","position":0,"seek":54102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"00 Prime Time 01 Aradhana = 19-07-2024","artist":"Radio Sharda","album":null,"uri":"http://stream.zenolive.com/g4ua0b105eeuv","trackType":""} Jul 19 19:47:18 volumio volumio[997]: verbose: CURRENT POSITION 0 Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::syncState stateService play Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::syncState currentStatus play Jul 19 19:47:18 volumio volumio[997]: info: Received an update from plugin. extracting info from payload Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:18 volumio volumio[997]: info: CoreStateMachine::pushState Jul 19 19:47:18 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jul 19 19:47:18 volumio volumio[997]: info: ------------------------------ 264ms Jul 19 19:47:18 volumio volumio[997]: info: ------------------------------ 263ms Jul 19 19:47:18 volumio volumio[997]: info: ------------------------------ 263ms Jul 19 19:47:18 volumio volumio[997]: info: ------------------------------ 262ms Jul 19 19:47:18 volumio volumio[997]: info: ------------------------------ 261ms Jul 19 19:47:18 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:18 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:18 volumio sudo[2673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:18 volumio sudo[2673]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:18 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:18 volumio sudo[2676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:18 volumio sudo[2676]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:18 volumio sudo[2673]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:18 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:18 volumio sudo[2676]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:18 volumio sudo[2679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:18 volumio sudo[2679]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:18 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:18 volumio sudo[2679]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:18 volumio sudo[2682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:18 volumio sudo[2682]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:18 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:18 volumio sudo[2682]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:18 volumio sudo[2685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:18 volumio sudo[2685]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:18 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:18 volumio sudo[2685]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:18 volumio sudo[2688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:18 volumio sudo[2688]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:18 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:18 volumio sudo[2691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:18 volumio sudo[2691]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:18 volumio sudo[2688]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:18 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:18 volumio sudo[2691]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:18 volumio sudo[2694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:18 volumio sudo[2694]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:18 volumio volumio[997]: info: PeppySpectrum ---peppyspectrum status play Jul 19 19:47:18 volumio sudo[2697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:18 volumio sudo[2694]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:18 volumio sudo[2697]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:18 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:18 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:18 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:18 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:18 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:18 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:18 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:18 volumio sudo[2700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 19 19:47:18 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:18 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jul 19 19:47:18 volumio sudo[2697]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:18 volumio sudo[2700]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 19:47:18 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:18 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:18 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:18 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:18 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:18 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:18 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:18 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:18 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:47:18 volumio sudo[2700]: pam_unix(sudo:session): session closed for user root Jul 19 19:47:18 volumio volumio[997]: info: peppyspectrum Daemon Started Jul 19 19:48:09 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 19 19:48:09 volumio volumio[997]: info: Preload queue cleared Jul 19 19:48:11 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 19 19:48:11 volumio volumio[997]: info: Preload queue cleared Jul 19 19:48:14 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 19 19:48:14 volumio volumio[997]: info: Preload queue cleared Jul 19 19:48:15 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 19 19:48:15 volumio volumio[997]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 19:48:15 volumio volumio[997]: TypeError: Cannot read property 'length' of undefined Jul 19 19:48:15 volumio volumio[997]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jul 19 19:48:15 volumio volumio[997]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jul 19 19:48:15 volumio volumio[997]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jul 19 19:48:15 volumio volumio[997]: at Parser.emit (events.js:315:20) Jul 19 19:48:15 volumio volumio[997]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jul 19 19:48:15 volumio volumio[997]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jul 19 19:48:15 volumio volumio[997]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jul 19 19:48:15 volumio volumio[997]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jul 19 19:48:15 volumio volumio[997]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jul 19 19:48:15 volumio volumio[997]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jul 19 19:48:15 volumio volumio[997]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jul 19 19:48:15 volumio volumio[997]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jul 19 19:48:15 volumio volumio[997]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jul 19 19:48:15 volumio volumio[997]: at IncomingMessage.emit (events.js:327:22) Jul 19 19:48:15 volumio volumio[997]: at endReadableNT (internal/streams/readable.js:1327:12) Jul 19 19:48:15 volumio volumio[997]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 19 19:48:15 volumio volumio[997]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 19:48:15 volumio sudo[2826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-19 19:47 Jul 19 19:48:15 volumio sudo[2826]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"