Dec 10 15:03:00 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 10 15:03:04 volumio volumio[1139]: info: Disabling MyMusic plugin cd_controller Dec 10 15:03:04 volumio volumio[1139]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service cd_controller Dec 10 15:03:04 volumio volumio[1139]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Dec 10 15:03:04 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 15:03:04 volumio volumio[1139]: Cannot find translation for source YouTube Music Dec 10 15:03:04 volumio volumio[1139]: info: Stopping UDEV Watcher for CD Dec 10 15:03:04 volumio volumio[1139]: info: Disabling plugin cd_controller Dec 10 15:03:04 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 10 15:03:08 volumio volumio[1139]: info: Enabling MyMusic plugin cd_controller Dec 10 15:03:08 volumio volumio[1139]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service cd_controller Dec 10 15:03:08 volumio volumio[1139]: info: Enabling plugin cd_controller Dec 10 15:03:08 volumio volumio[1139]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Dec 10 15:03:08 volumio volumio[1139]: info: Preparing CD Folders Dec 10 15:03:08 volumio volumio[1139]: info: Adding CD REST API Endpoints Dec 10 15:03:08 volumio volumio[1139]: info: Updating cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 10 15:03:08 volumio volumio[1139]: info: Starting UDEV Watcher for CD Dec 10 15:03:08 volumio volumio[1139]: info: Detecting CD presence with UDEV Dec 10 15:03:08 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Dec 10 15:03:08 volumio sudo[2092]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /dev/sr0 Dec 10 15:03:08 volumio sudo[2092]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 15:03:08 volumio sudo[2092]: pam_unix(sudo:session): session closed for user root Dec 10 15:03:08 volumio sudo[2096]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /dev/sr1 Dec 10 15:03:08 volumio sudo[2096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 15:03:08 volumio sudo[2096]: pam_unix(sudo:session): session closed for user root Dec 10 15:03:08 volumio volumio[1139]: /bin/chmod: cannot access '/dev/sr1': No such file or directory Dec 10 15:03:08 volumio volumio[1139]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 10 15:03:08 volumio volumio[1139]: info: [1765375388920] CoreMusicLibrary::Adding element Audio CD Dec 10 15:03:08 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 15:03:08 volumio volumio[1139]: Cannot find translation for source YouTube Music Dec 10 15:03:08 volumio volumio[1139]: Cannot find translation for source Audio CD Dec 10 15:03:09 volumio volumio[1139]: info: [cd-plugin] Set CD speed to 1X Dec 10 15:03:09 volumio volumio[1139]: info: Done. Dec 10 15:03:09 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 10 15:03:12 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 10 15:03:14 volumio volumio[1139]: info: [cd-plugin] Set CD speed to 1X Dec 10 15:03:16 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 10 15:03:18 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:18 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:18 volumio volumio[1139]: info: Could not get CDDB Entry for unknown DiscID Dec 10 15:03:19 volumio volumio[1139]: error: GETCD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:19 volumio volumio[1139]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 10 15:03:19 volumio volumio[1139]: info: [1765375399025] CoreMusicLibrary::Adding element Audio CD Dec 10 15:03:19 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 15:03:19 volumio volumio[1139]: Cannot find translation for source YouTube Music Dec 10 15:03:19 volumio volumio[1139]: Cannot find translation for source Audio CD Dec 10 15:03:20 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 10 15:03:24 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 10 15:03:27 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:03:29 volumio volumio[1139]: info: Executing endpoint metavolumio Dec 10 15:03:29 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 10 15:03:30 volumio volumio[1139]: info: CoreCommandRouter::volumioGetQueue Dec 10 15:03:30 volumio volumio[1139]: info: CoreStateMachine::getQueue Dec 10 15:03:30 volumio volumio[1139]: info: CorePlayQueue::getQueue Dec 10 15:03:32 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: cd_controller , handleBrowseUri Dec 10 15:03:38 volumio kernel: usb usb2-port1: over-current change #1 Dec 10 15:03:38 volumio kernel: usb usb2-port2: over-current change #1 Dec 10 15:03:39 volumio kernel: usb usb2-port3: over-current change #1 Dec 10 15:03:39 volumio kernel: usb usb2-port4: over-current change #1 Dec 10 15:03:39 volumio kernel: usb 1-1-port1: over-current change #1 Dec 10 15:03:39 volumio kernel: scsi_io_completion_action: 243 callbacks suppressed Dec 10 15:03:39 volumio kernel: sr 0:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s Dec 10 15:03:39 volumio kernel: sr 0:0:0:0: [sr0] tag#0 CDB: opcode=0xbb bb 00 ff ff ff ff 00 00 00 00 00 00 Dec 10 15:03:39 volumio kernel: usb 1-1.1: USB disconnect, device number 3 Dec 10 15:03:39 volumio kernel: usb 1-1-port2: over-current change #1 Dec 10 15:03:39 volumio kernel: usb 1-1-port3: over-current change #1 Dec 10 15:03:40 volumio kernel: usb 1-1-port4: over-current change #1 Dec 10 15:03:42 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:42 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:42 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:42 volumio volumio[1139]: error: Could not fetch whole CD Info Dec 10 15:03:42 volumio volumio[1139]: info: Preload queue cleared Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track0 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track1 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track2 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track3 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track4 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track5 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track6 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track7 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track8 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track9 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track10 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track11 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track12 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track13 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track14 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track15 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track16 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track17 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track18 Dec 10 15:03:42 volumio volumio[1139]: info: Preloading song: cdaudio/track19 Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track0 in service cd_controller Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track1 in service cd_controller Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track2 in service cd_controller Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track3 in service cd_controller Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track4 in service cd_controller Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track5 in service cd_controller Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track6 in service cd_controller Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track7 in service cd_controller Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track8 in service cd_controller Dec 10 15:03:42 volumio kernel: usb 1-1.1: new high-speed USB device number 4 using xhci_hcd Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track9 in service cd_controller Dec 10 15:03:42 volumio kernel: usb 1-1.1: New USB device found, idVendor=0e8d, idProduct=1806, bcdDevice= 0.00 Dec 10 15:03:42 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 10 15:03:42 volumio kernel: usb 1-1.1: Product: MT1806 Dec 10 15:03:42 volumio kernel: usb 1-1.1: Manufacturer: MediaTek Inc Dec 10 15:03:42 volumio kernel: usb 1-1.1: SerialNumber: R8X76GAD10157C Dec 10 15:03:42 volumio kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected Dec 10 15:03:42 volumio kernel: scsi host0: usb-storage 1-1.1:1.0 Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track10 in service cd_controller Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track11 in service cd_controller Dec 10 15:03:42 volumio volumio[1139]: info: Exploding uri cdaudio/track12 in service cd_controller Dec 10 15:03:43 volumio volumio[1139]: info: Exploding uri cdaudio/track13 in service cd_controller Dec 10 15:03:43 volumio volumio[1139]: info: Exploding uri cdaudio/track14 in service cd_controller Dec 10 15:03:43 volumio volumio[1139]: info: Exploding uri cdaudio/track15 in service cd_controller Dec 10 15:03:43 volumio volumio[1139]: info: Exploding uri cdaudio/track16 in service cd_controller Dec 10 15:03:43 volumio volumio[1139]: info: Exploding uri cdaudio/track17 in service cd_controller Dec 10 15:03:43 volumio volumio[1139]: info: Exploding uri cdaudio/track18 in service cd_controller Dec 10 15:03:43 volumio volumio[1139]: info: Exploding uri cdaudio/track19 in service cd_controller Dec 10 15:03:43 volumio kernel: scsi 0:0:0:0: CD-ROM TSSTcorp CDDVDW SE-208DB TS01 PQ: 0 ANSI: 0 Dec 10 15:03:43 volumio kernel: sr 0:0:0:0: Power-on or device reset occurred Dec 10 15:03:43 volumio kernel: sr 0:0:0:0: [sr0] scsi3-mmc drive: 8x/24x writer dvd-ram cd/rw xa/form2 cdda tray Dec 10 15:03:43 volumio kernel: sr 0:0:0:0: Attached scsi CD-ROM sr0 Dec 10 15:03:43 volumio kernel: sr 0:0:0:0: Attached scsi generic sg0 type 5 Dec 10 15:03:44 volumio volumio[1139]: info: Preload queue cleared Dec 10 15:03:44 volumio volumio[1139]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 10 15:03:44 volumio volumio[1139]: info: CoreStateMachine::ClearQueue Dec 10 15:03:44 volumio volumio[1139]: info: CoreStateMachine::stop Dec 10 15:03:44 volumio volumio[1139]: info: CoreStateMachine::serviceStop Dec 10 15:03:44 volumio volumio[1139]: info: Received STOP, but no service to execute it Dec 10 15:03:44 volumio volumio[1139]: info: CorePlayQueue::clearPlayQueue Dec 10 15:03:44 volumio volumio[1139]: info: CorePlayQueue::saveQueue Dec 10 15:03:44 volumio volumio[1139]: info: CoreCommandRouter::volumioPushQueue Dec 10 15:03:44 volumio volumio[1139]: info: CoreStateMachine::addQueueItems Dec 10 15:03:44 volumio volumio[1139]: info: CorePlayQueue::addQueueItems Dec 10 15:03:44 volumio volumio[1139]: info: Preload queue cleared Dec 10 15:03:44 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track0 Dec 10 15:03:44 volumio volumio[1139]: info: Exploding uri cdaudio/track0 in service cd_controller Dec 10 15:03:45 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:45 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:45 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:45 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:45 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:45 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:45 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:45 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:45 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:45 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:46 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:46 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:46 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:46 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:46 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:46 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:46 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:46 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:46 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:46 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:46 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:47 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:47 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:47 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:47 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:47 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:47 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:47 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:47 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:47 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:47 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:47 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:47 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:47 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:47 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:47 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:47 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:47 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:47 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:47 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:47 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:47 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:47 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:47 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:47 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:47 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:47 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:47 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:47 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:47 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:47 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:47 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:47 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:47 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:47 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:47 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:48 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:48 volumio volumio[1139]: info: CoreCommandRouter::volumioPushQueue Dec 10 15:03:48 volumio volumio[1139]: info: CorePlayQueue::saveQueue Dec 10 15:03:48 volumio volumio[1139]: info: CoreStateMachine::updateTrackBlock Dec 10 15:03:48 volumio volumio[1139]: info: CorePlayQueue::getTrackBlock Dec 10 15:03:48 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:03:48 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 10 15:03:48 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:03:48 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 10 15:03:48 volumio volumio[1139]: info: CoreCommandRouter::volumioPlay Dec 10 15:03:48 volumio volumio[1139]: verbose: UNSET VOLATILE: Service: undefined Dec 10 15:03:48 volumio volumio[1139]: ------------------------------------ BT MESSAGE: [FUNC] detachBluetooth Dec 10 15:03:48 volumio volumio[1139]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Dec 10 15:03:48 volumio volumio[1139]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Dec 10 15:03:48 volumio volumio[1139]: info: CoreStateMachine::play index 0 Dec 10 15:03:48 volumio volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 15:03:48 volumio volumio[1139]: info: CoreStateMachine::addQueueItems Dec 10 15:03:48 volumio volumio[1139]: info: CorePlayQueue::addQueueItems Dec 10 15:03:48 volumio volumio[1139]: info: Preload queue cleared Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track1 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track1 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track2 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track2 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track3 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track3 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track4 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track4 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track5 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track5 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track6 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track6 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track7 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track7 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track8 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track8 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track9 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track9 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track10 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track10 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track11 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track11 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track12 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track12 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track13 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track13 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track14 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track14 in service cd_controller Dec 10 15:03:48 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track15 Dec 10 15:03:48 volumio volumio[1139]: info: Exploding uri cdaudio/track15 in service cd_controller Dec 10 15:03:49 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track16 Dec 10 15:03:49 volumio volumio[1139]: info: Exploding uri cdaudio/track16 in service cd_controller Dec 10 15:03:49 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track17 Dec 10 15:03:49 volumio volumio[1139]: info: Exploding uri cdaudio/track17 in service cd_controller Dec 10 15:03:49 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track18 Dec 10 15:03:49 volumio volumio[1139]: info: Exploding uri cdaudio/track18 in service cd_controller Dec 10 15:03:49 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track19 Dec 10 15:03:49 volumio volumio[1139]: info: Exploding uri cdaudio/track19 in service cd_controller Dec 10 15:03:49 volumio volumio[1139]: ------------------------------------ BT MESSAGE: Bluetooth audio output disabled. Dec 10 15:03:49 volumio volumio[1139]: info: CoreStateMachine::stop Dec 10 15:03:49 volumio volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 15:03:49 volumio volumio[1139]: info: CoreStateMachine::resetVolumioState Dec 10 15:03:49 volumio volumio[1139]: info: CoreStateMachine::getcurrentVolume Dec 10 15:03:49 volumio volumio[1139]: info: CoreCommandRouter::volumioRetrievevolume Dec 10 15:03:49 volumio volumio[1139]: info: CoreStateMachine::play index undefined Dec 10 15:03:49 volumio volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 15:03:49 volumio volumio[1139]: info: CoreCommandRouter::volumioStop Dec 10 15:03:49 volumio volumio[1139]: info: CoreStateMachine::stop Dec 10 15:03:49 volumio volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 15:03:49 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:49 volumio volumio[1139]: info: CoreStateMachine::startPlaybackTimer Dec 10 15:03:49 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:49 volumio volumio[1139]: info: CoreCommandRouter::volumioGetVisibleSources Dec 10 15:03:49 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 15:03:49 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 10 15:03:49 volumio volumio[1139]: verbose: ControllerMpd::clearAddPlayTracks cdda:///1 Dec 10 15:03:49 volumio volumio[1139]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 15:03:49 volumio volumio[1139]: info: sendMpdCommand stop took 66 milliseconds Dec 10 15:03:49 volumio volumio[1139]: verbose: ControllerMpd::sendMpdCommand clear Dec 10 15:03:49 volumio volumio[1139]: info: Dec 10 15:03:49 volumio volumio[1139]: ---------------------------- MPD announces system playlist update Dec 10 15:03:49 volumio volumio[1139]: info: Ignoring MPD Status Update Dec 10 15:03:49 volumio volumio[1139]: info: sendMpdCommand clear took 54 milliseconds Dec 10 15:03:49 volumio volumio[1139]: verbose: ControllerMpd::sendMpdCommand add "cdda:///1" Dec 10 15:03:49 volumio volumio[1139]: error: updateQueue error: null Dec 10 15:03:49 volumio volumio[1139]: info: Dec 10 15:03:49 volumio volumio[1139]: ---------------------------- MPD announces system playlist update Dec 10 15:03:49 volumio volumio[1139]: info: Ignoring MPD Status Update Dec 10 15:03:49 volumio volumio[1139]: info: ------------------------------ 75ms Dec 10 15:03:49 volumio volumio[1139]: info: sendMpdCommand add "cdda:///1" took 73 milliseconds Dec 10 15:03:49 volumio volumio[1139]: verbose: ControllerMpd::sendMpdCommand play Dec 10 15:03:49 volumio volumio[1139]: info: ------------------------------ 3ms Dec 10 15:03:49 volumio volumio[1139]: info: sendMpdCommand play took 94 milliseconds Dec 10 15:03:49 volumio volumio[1139]: info: Dec 10 15:03:49 volumio volumio[1139]: ---------------------------- MPD announces state update: player Dec 10 15:03:49 volumio volumio[1139]: info: ControllerMpd::getState Dec 10 15:03:49 volumio volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Dec 10 15:03:50 volumio volumio[1139]: info: CoreStateMachine::pushState Dec 10 15:03:50 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:50 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 15:03:50 volumio volumio[1139]: info: CoreCommandRouter::volumioPushState Dec 10 15:03:50 volumio volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Dec 10 15:03:50 volumio volumio[1139]: info: MRS: Pushing multiroomSync output Dec 10 15:03:50 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:03:50 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:50 volumio volumio[1139]: info: CoreStateMachine::updateTrackBlock Dec 10 15:03:50 volumio volumio[1139]: info: CorePlayQueue::getTrackBlock Dec 10 15:03:50 volumio volumio[1139]: info: CoreCommandRouter::volumioRetrievevolume Dec 10 15:03:50 volumio volumio[1139]: info: Dec 10 15:03:50 volumio volumio[1139]: ---------------------------- MPD announces state update: player Dec 10 15:03:50 volumio volumio[1139]: info: ControllerMpd::getState Dec 10 15:03:50 volumio volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Dec 10 15:03:50 volumio volumio[1139]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 10 15:03:50 volumio volumio[1139]: info: sendMpdCommand status took 844 milliseconds Dec 10 15:03:50 volumio volumio[1139]: verbose: ControllerMpd::parseState Dec 10 15:03:50 volumio volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 15:03:51 volumio volumio[1139]: info: CoreStateMachine::pushState Dec 10 15:03:51 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:51 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 15:03:51 volumio volumio[1139]: info: CoreCommandRouter::volumioPushState Dec 10 15:03:51 volumio volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Dec 10 15:03:51 volumio volumio[1139]: info: MRS: Pushing multiroomSync output Dec 10 15:03:51 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:03:51 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:51 volumio volumio[1139]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 10 15:03:51 volumio volumio[1139]: info: sendMpdCommand status took 1072 milliseconds Dec 10 15:03:51 volumio volumio[1139]: info: sendMpdCommand clearerror took 883 milliseconds Dec 10 15:03:51 volumio volumio[1139]: info: sendMpdCommand playlistinfo took 828 milliseconds Dec 10 15:03:51 volumio volumio[1139]: verbose: ControllerMpd::parseState Dec 10 15:03:51 volumio volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 15:03:51 volumio volumio[1139]: verbose: ControllerMpd::parseTrackInfo Dec 10 15:03:51 volumio volumio[1139]: info: ControllerMpd::pushState Dec 10 15:03:51 volumio volumio[1139]: info: CoreCommandRouter::servicePushState Dec 10 15:03:51 volumio volumio[1139]: info: CoreStateMachine::pushState Dec 10 15:03:51 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:51 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 15:03:51 volumio volumio[1139]: info: CoreCommandRouter::volumioPushState Dec 10 15:03:51 volumio volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Dec 10 15:03:51 volumio volumio[1139]: info: MRS: Pushing multiroomSync output Dec 10 15:03:51 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:03:51 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:51 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:51 volumio volumio[1139]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Dec 10 15:03:51 volumio volumio[1139]: verbose: CURRENT POSITION 0 Dec 10 15:03:51 volumio volumio[1139]: info: CoreStateMachine::syncState stateService stop Dec 10 15:03:51 volumio volumio[1139]: info: CoreStateMachine::syncState currentStatus stop Dec 10 15:03:51 volumio volumio[1139]: info: CoreStateMachine::pushState Dec 10 15:03:51 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:51 volumio volumio[1139]: info: CoreCommandRouter::volumioPushState Dec 10 15:03:51 volumio volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Dec 10 15:03:51 volumio volumio[1139]: info: MRS: Pushing multiroomSync output Dec 10 15:03:51 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:03:51 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:51 volumio volumio[1139]: info: No code Dec 10 15:03:51 volumio volumio[1139]: info: CoreStateMachine::pushState Dec 10 15:03:51 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:51 volumio volumio[1139]: info: CoreCommandRouter::volumioPushState Dec 10 15:03:52 volumio volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Dec 10 15:03:52 volumio volumio[1139]: info: MRS: Pushing multiroomSync output Dec 10 15:03:52 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:03:52 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:52 volumio volumio[1139]: info: ------------------------------ 2271ms Dec 10 15:03:52 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:52 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:52 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:52 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:52 volumio volumio[1139]: info: sendMpdCommand clearerror took 679 milliseconds Dec 10 15:03:52 volumio volumio[1139]: info: sendMpdCommand playlistinfo took 634 milliseconds Dec 10 15:03:52 volumio volumio[1139]: verbose: ControllerMpd::parseTrackInfo Dec 10 15:03:52 volumio volumio[1139]: info: ControllerMpd::pushState Dec 10 15:03:52 volumio volumio[1139]: info: CoreCommandRouter::servicePushState Dec 10 15:03:52 volumio volumio[1139]: info: CoreStateMachine::pushState Dec 10 15:03:52 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:52 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 15:03:52 volumio volumio[1139]: info: CoreCommandRouter::volumioPushState Dec 10 15:03:52 volumio volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Dec 10 15:03:52 volumio volumio[1139]: info: MRS: Pushing multiroomSync output Dec 10 15:03:52 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:03:52 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:52 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:52 volumio volumio[1139]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Dec 10 15:03:52 volumio volumio[1139]: verbose: CURRENT POSITION 0 Dec 10 15:03:52 volumio volumio[1139]: info: CoreStateMachine::syncState stateService stop Dec 10 15:03:52 volumio volumio[1139]: info: CoreStateMachine::syncState currentStatus stop Dec 10 15:03:52 volumio volumio[1139]: info: CoreStateMachine::pushState Dec 10 15:03:52 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:52 volumio volumio[1139]: info: CoreCommandRouter::volumioPushState Dec 10 15:03:52 volumio volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Dec 10 15:03:52 volumio volumio[1139]: info: MRS: Pushing multiroomSync output Dec 10 15:03:52 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:03:52 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:52 volumio volumio[1139]: info: No code Dec 10 15:03:52 volumio volumio[1139]: info: CoreStateMachine::pushState Dec 10 15:03:52 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:52 volumio volumio[1139]: info: CoreCommandRouter::volumioPushState Dec 10 15:03:52 volumio volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Dec 10 15:03:52 volumio volumio[1139]: info: MRS: Pushing multiroomSync output Dec 10 15:03:52 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:03:52 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:03:52 volumio volumio[1139]: info: ------------------------------ 2047ms Dec 10 15:03:52 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:52 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:52 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:52 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:52 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:52 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:52 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:52 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:52 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:52 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:52 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:52 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:52 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:52 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:52 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:52 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:52 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:52 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:52 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:52 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:52 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:52 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:52 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:52 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:52 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:52 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:52 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:52 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:53 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:53 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:53 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:53 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:53 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:53 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:53 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:53 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:53 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:53 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:53 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:53 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:53 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:53 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:53 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:53 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:53 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:53 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:53 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:53 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:53 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:53 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:53 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:53 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:53 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:53 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:53 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:53 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:53 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:53 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:03:53 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:03:53 volumio volumio[1139]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded? Dec 10 15:03:53 volumio volumio[1139]: [WARNING] Error trying to calculate disc ids without lead-out information. Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:03:53 volumio volumio[1139]: info: CoreCommandRouter::volumioPushQueue Dec 10 15:03:53 volumio volumio[1139]: info: CorePlayQueue::saveQueue Dec 10 15:03:53 volumio volumio[1139]: info: CoreStateMachine::updateTrackBlock Dec 10 15:03:53 volumio volumio[1139]: info: CorePlayQueue::getTrackBlock Dec 10 15:03:53 volumio volumio[1139]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Dec 10 15:03:53 volumio volumio[1139]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Dec 10 15:03:53 volumio volumio[1139]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Dec 10 15:03:53 volumio volumio[1139]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Dec 10 15:03:53 volumio volumio[1139]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Dec 10 15:03:53 volumio volumio[1139]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Dec 10 15:03:53 volumio volumio[1139]: at Promise._failFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:449:13) Dec 10 15:03:53 volumio volumio[1139]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Dec 10 15:03:53 volumio volumio[1139]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Dec 10 15:03:57 volumio volumio[1139]: info: Preload queue cleared Dec 10 15:03:57 volumio volumio[1139]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 10 15:03:57 volumio volumio[1139]: info: CoreStateMachine::ClearQueue Dec 10 15:03:57 volumio volumio[1139]: info: CoreStateMachine::stop Dec 10 15:03:57 volumio volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 15:03:57 volumio volumio[1139]: info: CorePlayQueue::clearPlayQueue Dec 10 15:03:57 volumio volumio[1139]: info: CorePlayQueue::saveQueue Dec 10 15:03:57 volumio volumio[1139]: info: CoreCommandRouter::volumioPushQueue Dec 10 15:03:57 volumio volumio[1139]: info: CoreStateMachine::addQueueItems Dec 10 15:03:57 volumio volumio[1139]: info: CorePlayQueue::addQueueItems Dec 10 15:03:57 volumio volumio[1139]: info: Preload queue cleared Dec 10 15:03:57 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track0 Dec 10 15:03:57 volumio volumio[1139]: info: Exploding uri cdaudio/track0 in service cd_controller Dec 10 15:04:07 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Dec 10 15:04:07 volumio volumio[1139]: info: MRS: Starting browser stream Dec 10 15:04:07 volumio volumio[1139]: info: MRS: Setting this device as Streaming Server Dec 10 15:04:07 volumio volumio[1139]: info: Dec 10 15:04:07 volumio volumio[1139]: [1765375447023] ---------------------------- MRS: Setting Streaming Server Dec 10 15:04:07 volumio volumio[1139]: info: Enabled audio output: browserPlayback Dec 10 15:04:07 volumio volumio[1139]: info: MRS: enable multiroom server output Dec 10 15:04:07 volumio volumio[1139]: info: MRS: Set multiroom target PCM to volumioMultiRoom Dec 10 15:04:07 volumio volumio[1139]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Dec 10 15:04:07 volumio volumio[1139]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Dec 10 15:04:07 volumio volumio[1139]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Dec 10 15:04:07 volumio volumio[1139]: info: MRS: STARTING volumioStreaming Dec 10 15:04:07 volumio sudo[5956]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 10 15:04:07 volumio sudo[5956]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 15:04:07 volumio volumio[1139]: error: Error getting DISCID: Error: Command failed: /usr/bin/abcde -a cddb -N -d /dev/sr0 Dec 10 15:04:07 volumio volumio[1139]: which: no oggenc in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin) Dec 10 15:04:07 volumio sudo[5956]: pam_unix(sudo:session): session closed for user root Dec 10 15:04:07 volumio volumio[1139]: error: GETWHOLECD INFO Cannot read CDDB file Error: EISDIR: illegal operation on a directory, read Dec 10 15:04:07 volumio volumio[1139]: info: CoreCommandRouter::volumioPushQueue Dec 10 15:04:07 volumio sudo[5958]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Dec 10 15:04:07 volumio sudo[5958]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 15:04:07 volumio volumio[1139]: info: CorePlayQueue::saveQueue Dec 10 15:04:07 volumio volumio[1139]: info: CoreStateMachine::updateTrackBlock Dec 10 15:04:07 volumio volumio[1139]: info: CorePlayQueue::getTrackBlock Dec 10 15:04:07 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:04:07 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:04:07 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 10 15:04:07 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState Dec 10 15:04:07 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:04:07 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 10 15:04:07 volumio volumio[1139]: info: CoreCommandRouter::volumioPlay Dec 10 15:04:07 volumio volumio[1139]: info: CoreStateMachine::play index 0 Dec 10 15:04:07 volumio volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 15:04:07 volumio volumio[1139]: info: CoreStateMachine::addQueueItems Dec 10 15:04:07 volumio volumio[1139]: info: CorePlayQueue::addQueueItems Dec 10 15:04:07 volumio volumio[1139]: info: Preload queue cleared Dec 10 15:04:07 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track1 Dec 10 15:04:07 volumio volumio[1139]: info: Exploding uri cdaudio/track1 in service cd_controller Dec 10 15:04:07 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track2 Dec 10 15:04:07 volumio volumio[1139]: info: Exploding uri cdaudio/track2 in service cd_controller Dec 10 15:04:07 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track3 Dec 10 15:04:07 volumio volumio[1139]: info: Exploding uri cdaudio/track3 in service cd_controller Dec 10 15:04:07 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track4 Dec 10 15:04:07 volumio volumio[1139]: info: Exploding uri cdaudio/track4 in service cd_controller Dec 10 15:04:07 volumio systemd[1]: Started volumioStreaming.service - VolumioStreamingService. Dec 10 15:04:07 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track5 Dec 10 15:04:07 volumio volumio[1139]: info: Exploding uri cdaudio/track5 in service cd_controller Dec 10 15:04:07 volumio sudo[5958]: pam_unix(sudo:session): session closed for user root Dec 10 15:04:07 volumio sudo[5971]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 10 15:04:07 volumio sudo[5971]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 15:04:07 volumio sudo[5971]: pam_unix(sudo:session): session closed for user root Dec 10 15:04:07 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track6 Dec 10 15:04:07 volumio volumio[1139]: info: Exploding uri cdaudio/track6 in service cd_controller Dec 10 15:04:07 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track7 Dec 10 15:04:07 volumio volumio[1139]: info: Exploding uri cdaudio/track7 in service cd_controller Dec 10 15:04:07 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track8 Dec 10 15:04:07 volumio volumio[1139]: info: Exploding uri cdaudio/track8 in service cd_controller Dec 10 15:04:08 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track9 Dec 10 15:04:08 volumio volumio[1139]: info: Exploding uri cdaudio/track9 in service cd_controller Dec 10 15:04:08 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track10 Dec 10 15:04:08 volumio volumio[1139]: info: Exploding uri cdaudio/track10 in service cd_controller Dec 10 15:04:08 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track11 Dec 10 15:04:08 volumio volumio[1139]: info: Exploding uri cdaudio/track11 in service cd_controller Dec 10 15:04:08 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track12 Dec 10 15:04:08 volumio volumio[1139]: info: Exploding uri cdaudio/track12 in service cd_controller Dec 10 15:04:08 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track13 Dec 10 15:04:08 volumio volumio[1139]: info: Exploding uri cdaudio/track13 in service cd_controller Dec 10 15:04:08 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track14 Dec 10 15:04:08 volumio volumio[1139]: info: Exploding uri cdaudio/track14 in service cd_controller Dec 10 15:04:08 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track15 Dec 10 15:04:08 volumio volumio[1139]: info: Exploding uri cdaudio/track15 in service cd_controller Dec 10 15:04:08 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track16 Dec 10 15:04:08 volumio volumio[1139]: info: Exploding uri cdaudio/track16 in service cd_controller Dec 10 15:04:08 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track17 Dec 10 15:04:08 volumio volumio[1139]: info: Exploding uri cdaudio/track17 in service cd_controller Dec 10 15:04:08 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track18 Dec 10 15:04:08 volumio volumio[1139]: info: Exploding uri cdaudio/track18 in service cd_controller Dec 10 15:04:08 volumio volumio[1139]: info: Adding Item to queue: cdaudio/track19 Dec 10 15:04:08 volumio volumio[1139]: info: Exploding uri cdaudio/track19 in service cd_controller Dec 10 15:04:09 volumio volumio[1139]: info: CoreStateMachine::stop Dec 10 15:04:09 volumio volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 15:04:09 volumio volumio[1139]: info: CoreStateMachine::play index undefined Dec 10 15:04:09 volumio volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 15:04:09 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:04:09 volumio volumio[1139]: info: CoreStateMachine::startPlaybackTimer Dec 10 15:04:09 volumio volumio[1139]: info: CorePlayQueue::getTrack 0 Dec 10 15:04:09 volumio volumio[1139]: info: CoreCommandRouter::volumioGetVisibleSources Dec 10 15:04:09 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 15:04:09 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 10 15:04:09 volumio volumio[1139]: verbose: ControllerMpd::clearAddPlayTracks cdda:///1 Dec 10 15:04:09 volumio volumio[1139]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 15:04:09 volumio volumio[1139]: info: [cd-plugin] CD track playback started. Dec 10 15:04:12 volumio kernel: usb usb2-port1: over-current change #2 Dec 10 15:04:12 volumio kernel: usb usb2-port2: over-current change #2 Dec 10 15:04:12 volumio kernel: usb usb2-port3: over-current change #2 Dec 10 15:04:13 volumio kernel: usb usb2-port4: over-current change #2 Dec 10 15:04:13 volumio kernel: usb 1-1-port1: over-current change #2 Dec 10 15:04:13 volumio kernel: sr 0:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s Dec 10 15:04:13 volumio kernel: sr 0:0:0:0: [sr0] tag#0 CDB: opcode=0xbb bb 00 ff ff ff ff 00 00 00 00 00 00 Dec 10 15:04:13 volumio kernel: usb 1-1.1: USB disconnect, device number 4 Dec 10 15:04:13 volumio kernel: usb 1-1-port2: over-current change #2 Dec 10 15:04:13 volumio kernel: usb 1-1-port3: over-current change #2 Dec 10 15:04:14 volumio kernel: usb 1-1-port4: over-current change #2 Dec 10 15:04:16 volumio kernel: usb 1-1.1: new high-speed USB device number 5 using xhci_hcd Dec 10 15:04:16 volumio kernel: usb 1-1.1: New USB device found, idVendor=0e8d, idProduct=1806, bcdDevice= 0.00 Dec 10 15:04:16 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 10 15:04:16 volumio kernel: usb 1-1.1: Product: MT1806 Dec 10 15:04:16 volumio kernel: usb 1-1.1: Manufacturer: MediaTek Inc Dec 10 15:04:16 volumio kernel: usb 1-1.1: SerialNumber: R8X76GAD10157C Dec 10 15:04:16 volumio kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected Dec 10 15:04:16 volumio kernel: scsi host0: usb-storage 1-1.1:1.0 Dec 10 15:04:17 volumio kernel: scsi 0:0:0:0: CD-ROM TSSTcorp CDDVDW SE-208DB TS01 PQ: 0 ANSI: 0 Dec 10 15:04:17 volumio kernel: sr 0:0:0:0: Power-on or device reset occurred Dec 10 15:04:17 volumio kernel: sr 0:0:0:0: [sr0] scsi3-mmc drive: 8x/24x writer dvd-ram cd/rw xa/form2 cdda tray Dec 10 15:04:17 volumio kernel: sr 0:0:0:0: Attached scsi CD-ROM sr0 Dec 10 15:04:17 volumio kernel: sr 0:0:0:0: Attached scsi generic sg0 type 5 Dec 10 15:04:18 volumio volumio[1139]: warn: [cd-plugin] cdspeedctl: speed unsupported by drive Dec 10 15:04:18 volumio volumio[1139]: info: [cd-plugin] First attempt to set CD whisper speed. Dec 10 15:04:18 volumio volumio[1139]: info: [cd-plugin] CD track playback started. Dec 10 15:04:18 volumio kernel: sr 0:0:0:0: [sr0] CDROM not ready yet. Dec 10 15:04:20 volumio kernel: sr 0:0:0:0: [sr0] CDROM not ready yet. Dec 10 15:04:22 volumio kernel: sr 0:0:0:0: [sr0] CDROM not ready yet. Dec 10 15:04:24 volumio kernel: sr 0:0:0:0: [sr0] CDROM not ready yet. Dec 10 15:04:26 volumio kernel: sr 0:0:0:0: [sr0] CDROM not ready yet. Dec 10 15:04:29 volumio volumio[1139]: info: [cd-plugin] Set CD speed to 1X Dec 10 15:04:29 volumio volumio[1139]: info: [cd-plugin] First attempt to set CD whisper speed. Dec 10 15:04:29 volumio volumio[1139]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 15:04:29 volumio volumio[1139]: AxiosError: connect EHOSTUNREACH 192.168.2.25:1400 Dec 10 15:04:29 volumio volumio[1139]: at AxiosError.from (/myvolumio/plugins/audio_interface/multiroom/node_modules/axios/dist/node/axios.cjs:914:14) Dec 10 15:04:29 volumio volumio[1139]: at RedirectableRequest.handleRequestError (/myvolumio/plugins/audio_interface/multiroom/node_modules/axios/dist/node/axios.cjs:3515:25) Dec 10 15:04:29 volumio volumio[1139]: at RedirectableRequest.emit (node:events:514:28) Dec 10 15:04:29 volumio volumio[1139]: at eventHandlers. (/myvolumio/plugins/audio_interface/multiroom/node_modules/follow-redirects/index.js:49:24) Dec 10 15:04:29 volumio volumio[1139]: at ClientRequest.emit (node:events:514:28) Dec 10 15:04:29 volumio volumio[1139]: at Socket.socketErrorListener (node:_http_client:495:9) Dec 10 15:04:29 volumio volumio[1139]: at Socket.emit (node:events:514:28) Dec 10 15:04:29 volumio volumio[1139]: at emitErrorNT (node:internal/streams/destroy:151:8) Dec 10 15:04:29 volumio volumio[1139]: at emitErrorCloseNT (node:internal/streams/destroy:116:3) Dec 10 15:04:29 volumio volumio[1139]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) Dec 10 15:04:29 volumio volumio[1139]: at Axios.request (/myvolumio/plugins/audio_interface/multiroom/node_modules/axios/dist/node/axios.cjs:4731:41) Dec 10 15:04:29 volumio volumio[1139]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) { Dec 10 15:04:29 volumio volumio[1139]: port: 1400, Dec 10 15:04:29 volumio volumio[1139]: address: '192.168.2.25', Dec 10 15:04:29 volumio volumio[1139]: syscall: 'connect', Dec 10 15:04:29 volumio volumio[1139]: code: 'EHOSTUNREACH', Dec 10 15:04:29 volumio volumio[1139]: errno: -113, Dec 10 15:04:29 volumio volumio[1139]: config: { Dec 10 15:04:29 volumio volumio[1139]: transitional: { Dec 10 15:04:29 volumio volumio[1139]: silentJSONParsing: true, Dec 10 15:04:29 volumio volumio[1139]: forcedJSONParsing: true, Dec 10 15:04:29 volumio volumio[1139]: clarifyTimeoutError: false Dec 10 15:04:29 volumio volumio[1139]: }, Dec 10 15:04:29 volumio volumio[1139]: adapter: [ 'xhr', 'http', 'fetch' ], Dec 10 15:04:29 volumio volumio[1139]: transformRequest: [ [Function: transformRequest] ], Dec 10 15:04:29 volumio volumio[1139]: transformResponse: [ [Function: transformResponse] ], Dec 10 15:04:29 volumio volumio[1139]: timeout: 0, Dec 10 15:04:29 volumio volumio[1139]: xsrfCookieName: 'XSRF-TOKEN', Dec 10 15:04:29 volumio volumio[1139]: xsrfHeaderName: 'X-XSRF-TOKEN', Dec 10 15:04:29 volumio volumio[1139]: maxContentLength: -1, Dec 10 15:04:29 volumio volumio[1139]: maxBodyLength: -1, Dec 10 15:04:29 volumio volumio[1139]: env: { FormData: [Function], Blob: [class Blob] }, Dec 10 15:04:29 volumio volumio[1139]: validateStatus: [Function: validateStatus], Dec 10 15:04:29 volumio volumio[1139]: headers: Object [AxiosHeaders] { Dec 10 15:04:29 volumio volumio[1139]: Accept: 'application/json, text/plain, */*', Dec 10 15:04:29 volumio volumio[1139]: 'Content-Type': undefined, Dec 10 15:04:29 volumio volumio[1139]: 'User-Agent': 'axios/1.13.2', Dec 10 15:04:29 volumio volumio[1139]: 'Accept-Encoding': 'gzip, compress, deflate, br' Dec 10 15:04:29 volumio volumio[1139]: }, Dec 10 15:04:29 volumio volumio[1139]: url: 'http://192.168.2.25:1400/xml/device_description.xml', Dec 10 15:04:29 volumio volumio[1139]: allowAbsoluteUrls: true, Dec 10 15:04:29 volumio volumio[1139]: method: 'get', Dec 10 15:04:29 volumio volumio[1139]: data: undefined Dec 10 15:04:29 volumio volumio[1139]: }, Dec 10 15:04:29 volumio volumio[1139]: request: Writable { Dec 10 15:04:29 volumio volumio[1139]: _writableState: WritableState { Dec 10 15:04:29 volumio volumio[1139]: objectMode: false, Dec 10 15:04:29 volumio volumio[1139]: highWaterMark: 16384, Dec 10 15:04:29 volumio volumio[1139]: finalCalled: false, Dec 10 15:04:29 volumio volumio[1139]: needDrain: false, Dec 10 15:04:29 volumio volumio[1139]: ending: false, Dec 10 15:04:29 volumio volumio[1139]: ended: false, Dec 10 15:04:29 volumio volumio[1139]: finished: false, Dec 10 15:04:29 volumio volumio[1139]: destroyed: false, Dec 10 15:04:29 volumio volumio[1139]: decodeStrings: true, Dec 10 15:04:29 volumio volumio[1139]: defaultEncoding: 'utf8', Dec 10 15:04:29 volumio volumio[1139]: length: 0, Dec 10 15:04:29 volumio volumio[1139]: writing: false, Dec 10 15:04:29 volumio volumio[1139]: corked: 0, Dec 10 15:04:29 volumio volumio[1139]: sync: true, Dec 10 15:04:29 volumio volumio[1139]: bufferProcessing: false, Dec 10 15:04:29 volumio volumio[1139]: onwrite: [Function: bound onwrite], Dec 10 15:04:29 volumio volumio[1139]: writecb: null, Dec 10 15:04:29 volumio volumio[1139]: writelen: 0, Dec 10 15:04:29 volumio volumio[1139]: afterWriteTickInfo: null, Dec 10 15:04:29 volumio volumio[1139]: buffered: [], Dec 10 15:04:29 volumio volumio[1139]: bufferedIndex: 0, Dec 10 15:04:29 volumio volumio[1139]: allBuffers: true, Dec 10 15:04:29 volumio volumio[1139]: allNoop: true, Dec 10 15:04:29 volumio volumio[1139]: pendingcb: 0, Dec 10 15:04:29 volumio volumio[1139]: constructed: true, Dec 10 15:04:29 volumio volumio[1139]: prefinished: false, Dec 10 15:04:29 volumio volumio[1139]: errorEmitted: false, Dec 10 15:04:29 volumio volumio[1139]: emitClose: true, Dec 10 15:04:29 volumio volumio[1139]: autoDestroy: true, Dec 10 15:04:29 volumio volumio[1139]: errored: null, Dec 10 15:04:29 volumio volumio[1139]: closed: false, Dec 10 15:04:29 volumio volumio[1139]: closeEmitted: false, Dec 10 15:04:29 volumio volumio[1139]: [Symbol(kOnFinished)]: [] Dec 10 15:04:29 volumio volumio[1139]: }, Dec 10 15:04:29 volumio volumio[1139]: _events: [Object: null prototype] { Dec 10 15:04:29 volumio volumio[1139]: response: [Function: handleResponse], Dec 10 15:04:29 volumio volumio[1139]: error: [Function: handleRequestError], Dec 10 15:04:29 volumio volumio[1139]: socket: [Array] Dec 10 15:04:29 volumio volumio[1139]: }, Dec 10 15:04:29 volumio volumio[1139]: _eventsCount: 3, Dec 10 15:04:29 volumio volumio[1139]: _maxListeners: undefined, Dec 10 15:04:29 volumio volumio[1139]: _options: { Dec 10 15:04:29 volumio volumio[1139]: maxRedirects: 21, Dec 10 15:04:29 volumio volumio[1139]: maxBodyLength: Infinity, Dec 10 15:04:29 volumio volumio[1139]: protocol: 'http:', Dec 10 15:04:29 volumio volumio[1139]: path: '/xml/device_description.xml', Dec 10 15:04:29 volumio volumio[1139]: method: 'GET', Dec 10 15:04:29 volumio volumio[1139]: headers: [Object: null prototype], Dec 10 15:04:29 volumio volumio[1139]: agents: [Object], Dec 10 15:04:29 volumio volumio[1139]: auth: undefined, Dec 10 15:04:29 volumio volumio[1139]: family: undefined, Dec 10 15:04:29 volumio volumio[1139]: beforeRedirect: [Function: dispatchBeforeRedirect], Dec 10 15:04:29 volumio volumio[1139]: beforeRedirects: [Object], Dec 10 15:04:29 volumio volumio[1139]: http2Options: undefined, Dec 10 15:04:29 volumio volumio[1139]: hostname: '192.168.2.25', Dec 10 15:04:29 volumio volumio[1139]: port: '1400', Dec 10 15:04:29 volumio volumio[1139]: agent: undefined, Dec 10 15:04:29 volumio volumio[1139]: nativeProtocols: [Object], Dec 10 15:04:29 volumio volumio[1139]: pathname: '/xml/device_description.xml' Dec 10 15:04:29 volumio volumio[1139]: }, Dec 10 15:04:29 volumio volumio[1139]: _ended: true, Dec 10 15:04:29 volumio volumio[1139]: _ending: true, Dec 10 15:04:29 volumio volumio[1139]: _redirectCount: 0, Dec 10 15:04:29 volumio volumio[1139]: _redirects: [], Dec 10 15:04:29 volumio volumio[1139]: _requestBodyLength: 0, Dec 10 15:04:29 volumio volumio[1139]: _requestBodyBuffers: [], Dec 10 15:04:29 volumio volumio[1139]: _onNativeResponse: [Function (anonymous)], Dec 10 15:04:29 volumio volumio[1139]: _currentRequest: ClientRequest { Dec 10 15:04:29 volumio volumio[1139]: _events: [Object: null prototype], Dec 10 15:04:29 volumio volumio[1139]: _eventsCount: 7, Dec 10 15:04:29 volumio volumio[1139]: _maxListeners: undefined, Dec 10 15:04:29 volumio volumio[1139]: outputData: [], Dec 10 15:04:29 volumio volumio[1139]: outputSize: 0, Dec 10 15:04:29 volumio volumio[1139]: writable: true, Dec 10 15:04:29 volumio volumio[1139]: destroyed: false, Dec 10 15:04:29 volumio volumio[1139]: _last: true, Dec 10 15:04:29 volumio volumio[1139]: chunkedEncoding: false, Dec 10 15:04:29 volumio volumio[1139]: shouldKeepAlive: true, Dec 10 15:04:29 volumio volumio[1139]: maxRequestsOnConnectionReached: false, Dec 10 15:04:29 volumio volumio[1139]: _defaultKeepAlive: true, Dec 10 15:04:29 volumio volumio[1139]: useChunkedEncodingByDefault: false, Dec 10 15:04:29 volumio volumio[1139]: sendDate: false, Dec 10 15:04:29 volumio volumio[1139]: _removedConnection: false, Dec 10 15:04:29 volumio volumio[1139]: _removedContLen: false, Dec 10 15:04:29 volumio volumio[1139]: _removedTE: false, Dec 10 15:04:29 volumio volumio[1139]: strictContentLength: false, Dec 10 15:04:29 volumio volumio[1139]: _contentLength: 0, Dec 10 15:04:29 volumio volumio[1139]: _hasBody: true, Dec 10 15:04:29 volumio volumio[1139]: _trailer: '', Dec 10 15:04:29 volumio volumio[1139]: finished: true, Dec 10 15:04:29 volumio volumio[1139]: _headerSent: true, Dec 10 15:04:29 volumio volumio[1139]: _closed: false, Dec 10 15:04:29 volumio volumio[1139]: socket: [Socket], Dec 10 15:04:29 volumio volumio[1139]: _header: 'GET /xml/device_description.xml HTTP/1.1\r\n' + Dec 10 15:04:29 volumio volumio[1139]: 'Accept: application/json, text/plain, */*\r\n' + Dec 10 15:04:29 volumio volumio[1139]: 'User-Agent: axios/1.13.2\r\n' + Dec 10 15:04:29 volumio volumio[1139]: 'Accept-Encoding: gzip, compress, deflate, br\r\n' + Dec 10 15:04:29 volumio volumio[1139]: 'Host: 192.168.2.25:1400\r\n' + Dec 10 15:04:29 volumio volumio[1139]: 'Connection: keep-alive\r\n' + Dec 10 15:04:29 volumio volumio[1139]: '\r\n', Dec 10 15:04:29 volumio volumio[1139]: _keepAliveTimeout: 0, Dec 10 15:04:29 volumio volumio[1139]: _onPendingData: [Function: nop], Dec 10 15:04:29 volumio volumio[1139]: agent: [Agent], Dec 10 15:04:29 volumio volumio[1139]: socketPath: undefined, Dec 10 15:04:29 volumio volumio[1139]: method: 'GET', Dec 10 15:04:29 volumio volumio[1139]: maxHeaderSize: undefined, Dec 10 15:04:29 volumio volumio[1139]: insecureHTTPParser: undefined, Dec 10 15:04:29 volumio volumio[1139]: joinDuplicateHeaders: undefined, Dec 10 15:04:29 volumio volumio[1139]: path: '/xml/device_description.xml', Dec 10 15:04:29 volumio volumio[1139]: _ended: false, Dec 10 15:04:29 volumio volumio[1139]: res: null, Dec 10 15:04:29 volumio volumio[1139]: aborted: false, Dec 10 15:04:29 volumio volumio[1139]: timeoutCb: [Function: emitRequestTimeout], Dec 10 15:04:29 volumio volumio[1139]: upgradeOrConnect: false, Dec 10 15:04:29 volumio volumio[1139]: parser: null, Dec 10 15:04:29 volumio volumio[1139]: maxHeadersCount: null, Dec 10 15:04:29 volumio volumio[1139]: reusedSocket: false, Dec 10 15:04:29 volumio volumio[1139]: host: '192.168.2.25', Dec 10 15:04:29 volumio volumio[1139]: protocol: 'http:', Dec 10 15:04:29 volumio volumio[1139]: _redirectable: [Circular *1], Dec 10 15:04:29 volumio volumio[1139]: [Symbol(kCapture)]: false, Dec 10 15:04:29 volumio volumio[1139]: [Symbol(kBytesWritten)]: 0, Dec 10 15:04:29 volumio volumio[1139]: [Symbol(kNeedDrain)]: false, Dec 10 15:04:29 volumio volumio[1139]: [Symbol(corked)]: 0, Dec 10 15:04:29 volumio volumio[1139]: [Symbol(kOutHeaders)]: [Object: null prototype], Dec 10 15:04:29 volumio volumio[1139]: [Symbol(errored)]: null, Dec 10 15:04:29 volumio volumio[1139]: [Symbol(kHighWaterMark)]: 16384, Dec 10 15:04:29 volumio volumio[1139]: [Symbol(kRejectNonStandardBodyWrites)]: false, Dec 10 15:04:29 volumio volumio[1139]: [Symbol(kUniqueHeaders)]: null Dec 10 15:04:29 volumio volumio[1139]: }, Dec 10 15:04:29 volumio volumio[1139]: _currentUrl: 'http://192.168.2.25:1400/xml/device_description.xml', Dec 10 15:04:29 volumio volumio[1139]: _timeout: null, Dec 10 15:04:29 volumio volumio[1139]: [Symbol(kCapture)]: false Dec 10 15:04:29 volumio volumio[1139]: }, Dec 10 15:04:29 volumio volumio[1139]: [cause]: Error: connect EHOSTUNREACH 192.168.2.25:1400 Dec 10 15:04:29 volumio volumio[1139]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Dec 10 15:04:29 volumio volumio[1139]: errno: -113, Dec 10 15:04:29 volumio volumio[1139]: code: 'EHOSTUNREACH', Dec 10 15:04:29 volumio volumio[1139]: syscall: 'connect', Dec 10 15:04:29 volumio volumio[1139]: address: '192.168.2.25', Dec 10 15:04:29 volumio volumio[1139]: port: 1400 Dec 10 15:04:29 volumio volumio[1139]: } Dec 10 15:04:29 volumio volumio[1139]: } Dec 10 15:04:29 volumio volumio[1139]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 15:04:32 volumio sudo[7605]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-10 15:03' Dec 10 15:04:32 volumio sudo[7605]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"