-- Logs begin at Sat 2025-11-29 05:59:20 UTC, end at Fri 2025-12-12 13:32:11 UTC. -- Dec 12 13:31:00 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:00 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:00 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:00 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:00 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:00 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:00 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:00 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:01 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:01 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:01 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:01 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:01 volumio2b systemd[1]: Starting Raspberry Pi temperature textfile collector... Dec 12 13:31:01 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:01 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:01 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:01 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:01 volumio2b systemd[1446]: Failed at step EXEC spawning /usr/local/bin/rpi_temp_collector.sh: Exec format error Dec 12 13:31:01 volumio2b systemd[1]: rpi-temp-collector.service: main process exited, code=exited, status=203/EXEC Dec 12 13:31:01 volumio2b systemd[1]: Failed to start Raspberry Pi temperature textfile collector. Dec 12 13:31:01 volumio2b systemd[1]: Unit rpi-temp-collector.service entered failed state. Dec 12 13:31:02 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:02 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:02 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:02 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:02 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:02 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:02 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:02 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:03 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:03 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:03 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:03 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:03 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:03 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:03 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:03 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:04 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:04 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:04 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:04 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:04 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:04 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:04 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:04 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:09 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:09 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:09 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:09 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:09 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:09 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:09 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:09 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:09 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:09 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:09 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:09 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:09 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:10 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:15 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:15 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:15 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:15 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:15 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:15 volumio2b kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Dec 12 13:31:15 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:15 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:15 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:16 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:16 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:16 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:16 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:16 volumio2b systemd[1]: Starting Raspberry Pi temperature textfile collector... Dec 12 13:31:16 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:16 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:16 volumio2b systemd[1479]: Failed at step EXEC spawning /usr/local/bin/rpi_temp_collector.sh: Exec format error Dec 12 13:31:16 volumio2b systemd[1]: rpi-temp-collector.service: main process exited, code=exited, status=203/EXEC Dec 12 13:31:16 volumio2b systemd[1]: Failed to start Raspberry Pi temperature textfile collector. Dec 12 13:31:16 volumio2b systemd[1]: Unit rpi-temp-collector.service entered failed state. Dec 12 13:31:16 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:16 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:17 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:17 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:17 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:17 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:17 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:17 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:17 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:17 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:18 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:18 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:18 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:18 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:18 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:18 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:18 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:18 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:19 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:19 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:19 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:19 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:19 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:19 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:19 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:19 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:20 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:20 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:20 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:20 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:20 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:20 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:20 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:20 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:21 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:21 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:21 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:21 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:21 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:21 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:21 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:21 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:22 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:22 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:22 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:22 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:22 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:22 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:22 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:22 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:23 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:23 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:23 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:23 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:23 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:23 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:23 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:23 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:24 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:24 volumio2b kernel: usb 1-1.4: new high-speed USB device number 17 using dwc_otg Dec 12 13:31:24 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:24 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:24 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:24 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:24 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:24 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:24 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:24 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:25 volumio2b kernel: usb 1-1.4: device not accepting address 17, error -71 Dec 12 13:31:25 volumio2b kernel: usb 1-1-port4: attempt power cycle Dec 12 13:31:25 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:25 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:25 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:25 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:25 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:25 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:25 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:25 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: new high-speed USB device number 18 using dwc_otg Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: New USB device found, idVendor=054c, idProduct=0899, bcdDevice= 1.00 Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: Product: Sony Audio Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: Manufacturer: Sony Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: SerialNumber: 70C94E2538F9 Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: uac_clock_source_is_valid(): cannot get clock validity for id 41 Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: USB disconnect, device number 18 Dec 12 13:31:26 volumio2b systemd-udevd[1517]: error opening ATTR{/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/sound/card5/controlC5/../uevent} for writing: No such file or directory Dec 12 13:31:26 volumio2b systemd-udevd[1517]: Failed to apply ACL on /dev/snd/controlC5: No such file or directory Dec 12 13:31:26 volumio2b volumio[803]: info: Dec 12 13:31:26 volumio2b volumio[803]: ---------------------------- USB Audio Device Attached Dec 12 13:31:26 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 12 13:31:26 volumio2b systemd-udevd[1516]: Failed to apply ACL on /dev/snd/pcmC5D0p: No such file or directory Dec 12 13:31:26 volumio2b volumio[803]: info: Dec 12 13:31:26 volumio2b volumio[803]: ---------------------------- USB Audio Device Detached Dec 12 13:31:26 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 12 13:31:26 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 13:31:26 volumio2b kernel: usb 1-1.4: new high-speed USB device number 19 using dwc_otg Dec 12 13:31:26 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:26 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:26 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:26 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:26 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:26 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:26 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:26 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:27 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:27 volumio2b kernel: usb 1-1.4: new high-speed USB device number 20 using dwc_otg Dec 12 13:31:27 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:27 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:27 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:27 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:28 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:28 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:28 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:28 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:28 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:28 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:28 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:28 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:28 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:28 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:28 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:28 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:29 volumio2b kernel: usb 1-1.4: device not accepting address 20, error -71 Dec 12 13:31:29 volumio2b kernel: usb 1-1-port4: attempt power cycle Dec 12 13:31:29 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:29 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:29 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:29 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:29 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:29 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:29 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:29 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:30 volumio2b kernel: usb 1-1.4: new high-speed USB device number 21 using dwc_otg Dec 12 13:31:30 volumio2b kernel: usb 1-1.4: New USB device found, idVendor=054c, idProduct=0899, bcdDevice= 1.00 Dec 12 13:31:30 volumio2b kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 12 13:31:30 volumio2b kernel: usb 1-1.4: Product: Sony Audio Dec 12 13:31:30 volumio2b kernel: usb 1-1.4: Manufacturer: Sony Dec 12 13:31:30 volumio2b kernel: usb 1-1.4: SerialNumber: 70C94E2538F9 Dec 12 13:31:30 volumio2b kernel: usb 1-1.4: uac_clock_source_is_valid(): cannot get clock validity for id 41 Dec 12 13:31:30 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:30 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:30 volumio2b kernel: usb 1-1.4: USB disconnect, device number 21 Dec 12 13:31:30 volumio2b systemd-udevd[1534]: error opening ATTR{/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/sound/card5/controlC5/../uevent} for writing: No such file or directory Dec 12 13:31:30 volumio2b systemd-udevd[1534]: Failed to apply ACL on /dev/snd/controlC5: No such file or directory Dec 12 13:31:30 volumio2b volumio[803]: info: Dec 12 13:31:30 volumio2b volumio[803]: ---------------------------- USB Audio Device Attached Dec 12 13:31:30 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 12 13:31:30 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:30 volumio2b systemd-udevd[1533]: Failed to apply ACL on /dev/snd/pcmC5D0p: No such file or directory Dec 12 13:31:30 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:30 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:30 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:30 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:30 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:30 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:30 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:30 volumio2b volumio[803]: info: Dec 12 13:31:30 volumio2b volumio[803]: ---------------------------- USB Audio Device Detached Dec 12 13:31:30 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 12 13:31:30 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 13:31:30 volumio2b kernel: usb 1-1.4: new high-speed USB device number 22 using dwc_otg Dec 12 13:31:31 volumio2b kernel: usb 1-1.4: device not accepting address 22, error -71 Dec 12 13:31:31 volumio2b kernel: usb 1-1.4: new high-speed USB device number 23 using dwc_otg Dec 12 13:31:31 volumio2b systemd[1]: Starting Raspberry Pi temperature textfile collector... Dec 12 13:31:31 volumio2b systemd[1543]: Failed at step EXEC spawning /usr/local/bin/rpi_temp_collector.sh: Exec format error Dec 12 13:31:31 volumio2b systemd[1]: rpi-temp-collector.service: main process exited, code=exited, status=203/EXEC Dec 12 13:31:31 volumio2b systemd[1]: Failed to start Raspberry Pi temperature textfile collector. Dec 12 13:31:31 volumio2b systemd[1]: Unit rpi-temp-collector.service entered failed state. Dec 12 13:31:31 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:31 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:31 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:31 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:31 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:31 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:31 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:31 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:32 volumio2b kernel: usb 1-1.4: device not accepting address 23, error -71 Dec 12 13:31:32 volumio2b kernel: usb 1-1-port4: attempt power cycle Dec 12 13:31:32 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:32 volumio2b kernel: usb 1-1.4: new high-speed USB device number 24 using dwc_otg Dec 12 13:31:32 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:32 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:32 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:32 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:32 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:32 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:32 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:33 volumio2b kernel: usb 1-1.4: device not accepting address 24, error -71 Dec 12 13:31:33 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:33 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:33 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:33 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:33 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:33 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:33 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:33 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:34 volumio2b kernel: usb 1-1.4: new high-speed USB device number 25 using dwc_otg Dec 12 13:31:34 volumio2b kernel: usb 1-1.4: New USB device found, idVendor=054c, idProduct=0899, bcdDevice= 1.00 Dec 12 13:31:34 volumio2b kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 12 13:31:34 volumio2b kernel: usb 1-1.4: Product: Sony Audio Dec 12 13:31:34 volumio2b kernel: usb 1-1.4: Manufacturer: Sony Dec 12 13:31:34 volumio2b kernel: usb 1-1.4: SerialNumber: 70C94E2538F9 Dec 12 13:31:34 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to retrieve sample rate range (clock 41) Dec 12 13:31:34 volumio2b kernel: usb 1-1.4: USB disconnect, device number 25 Dec 12 13:31:34 volumio2b systemd-udevd[1554]: error opening ATTR{/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/sound/card5/controlC5/../uevent} for writing: No such file or directory Dec 12 13:31:34 volumio2b systemd-udevd[1554]: Failed to apply ACL on /dev/snd/controlC5: No such file or directory Dec 12 13:31:34 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:34 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:34 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:34 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:34 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:34 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:34 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:34 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:34 volumio2b volumio[803]: info: Dec 12 13:31:34 volumio2b volumio[803]: ---------------------------- USB Audio Device Attached Dec 12 13:31:34 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 12 13:31:34 volumio2b systemd-udevd[1552]: Failed to apply ACL on /dev/snd/pcmC5D0p: No such file or directory Dec 12 13:31:34 volumio2b volumio[803]: info: Dec 12 13:31:34 volumio2b volumio[803]: ---------------------------- USB Audio Device Detached Dec 12 13:31:34 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 12 13:31:34 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 13:31:34 volumio2b kernel: usb 1-1.4: new high-speed USB device number 26 using dwc_otg Dec 12 13:31:35 volumio2b sudo[1563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 12 13:31:35 volumio2b sudo[1563]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 13:31:35 volumio2b sudo[1565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 12 13:31:35 volumio2b sudo[1563]: pam_unix(sudo:session): session closed for user root Dec 12 13:31:35 volumio2b sudo[1565]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 13:31:35 volumio2b sudo[1565]: pam_unix(sudo:session): session closed for user root Dec 12 13:31:35 volumio2b sudo[1583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 12 13:31:35 volumio2b sudo[1583]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 13:31:35 volumio2b sudo[1585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 12 13:31:35 volumio2b sudo[1583]: pam_unix(sudo:session): session closed for user root Dec 12 13:31:35 volumio2b sudo[1585]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 13:31:35 volumio2b sudo[1585]: pam_unix(sudo:session): session closed for user root Dec 12 13:31:35 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::volumioGetState Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 12 13:31:35 volumio2b volumio[803]: info: Listing playlists Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 12 13:31:35 volumio2b kernel: usb 1-1.4: new high-speed USB device number 27 using dwc_otg Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:35 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:35 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:35 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:36 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:36 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:36 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:36 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:36 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:36 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:36 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:36 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:36 volumio2b kernel: usb 1-1.4: device descriptor read/all, error -71 Dec 12 13:31:36 volumio2b kernel: usb 1-1-port4: attempt power cycle Dec 12 13:31:37 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:37 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:37 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:37 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:37 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:37 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:37 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:37 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:38 volumio2b kernel: usb 1-1.4: new high-speed USB device number 28 using dwc_otg Dec 12 13:31:38 volumio2b kernel: usb 1-1.4: New USB device found, idVendor=054c, idProduct=0899, bcdDevice= 1.00 Dec 12 13:31:38 volumio2b kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 12 13:31:38 volumio2b kernel: usb 1-1.4: Product: Sony Audio Dec 12 13:31:38 volumio2b kernel: usb 1-1.4: Manufacturer: Sony Dec 12 13:31:38 volumio2b kernel: usb 1-1.4: SerialNumber: 70C94E2538F9 Dec 12 13:31:38 volumio2b kernel: usb 1-1.4: USB disconnect, device number 28 Dec 12 13:31:38 volumio2b systemd-udevd[1614]: error opening ATTR{/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/sound/card5/controlC5/../uevent} for writing: No such file or directory Dec 12 13:31:38 volumio2b systemd-udevd[1614]: Failed to apply ACL on /dev/snd/controlC5: No such file or directory Dec 12 13:31:38 volumio2b volumio[803]: info: Dec 12 13:31:38 volumio2b volumio[803]: ---------------------------- USB Audio Device Attached Dec 12 13:31:38 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 12 13:31:38 volumio2b systemd-udevd[1612]: Failed to apply ACL on /dev/snd/pcmC5D0p: No such file or directory Dec 12 13:31:38 volumio2b volumio[803]: info: Dec 12 13:31:38 volumio2b volumio[803]: ---------------------------- USB Audio Device Detached Dec 12 13:31:38 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 12 13:31:38 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 13:31:38 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:38 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:38 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:38 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:38 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:38 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:38 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:38 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:38 volumio2b kernel: usb 1-1.4: new high-speed USB device number 29 using dwc_otg Dec 12 13:31:39 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:39 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:39 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:39 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:39 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:39 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:39 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:39 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:40 volumio2b kernel: usb 1-1.4: device not accepting address 29, error -71 Dec 12 13:31:40 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:40 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:40 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:40 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:40 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:40 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:40 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:40 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:41 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:41 volumio2b kernel: usb 1-1-port4: attempt power cycle Dec 12 13:31:41 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:41 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:41 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:41 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:41 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:41 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:41 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:41 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:42 volumio2b kernel: usb 1-1.4: new high-speed USB device number 31 using dwc_otg Dec 12 13:31:42 volumio2b kernel: usb 1-1.4: New USB device found, idVendor=054c, idProduct=0899, bcdDevice= 1.00 Dec 12 13:31:42 volumio2b kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 12 13:31:42 volumio2b kernel: usb 1-1.4: Product: Sony Audio Dec 12 13:31:42 volumio2b kernel: usb 1-1.4: Manufacturer: Sony Dec 12 13:31:42 volumio2b kernel: usb 1-1.4: SerialNumber: 70C94E2538F9 Dec 12 13:31:42 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:42 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:42 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:42 volumio2b kernel: usb 1-1.4: USB disconnect, device number 31 Dec 12 13:31:42 volumio2b systemd-udevd[1630]: error opening ATTR{/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/sound/card5/controlC5/../uevent} for writing: No such file or directory Dec 12 13:31:42 volumio2b systemd-udevd[1630]: Failed to apply ACL on /dev/snd/controlC5: No such file or directory Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:42 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:42 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:42 volumio2b volumio[803]: info: Dec 12 13:31:42 volumio2b volumio[803]: ---------------------------- USB Audio Device Attached Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 12 13:31:42 volumio2b systemd-udevd[1628]: Failed to apply ACL on /dev/snd/pcmC5D0p: No such file or directory Dec 12 13:31:42 volumio2b volumio[803]: info: Dec 12 13:31:42 volumio2b volumio[803]: ---------------------------- USB Audio Device Detached Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::volumioGetVisibleSources Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 12 13:31:42 volumio2b volumio[803]: info: CoreCommandRouter::volumioGetQueue Dec 12 13:31:42 volumio2b volumio[803]: info: CoreStateMachine::getQueue Dec 12 13:31:42 volumio2b volumio[803]: info: CorePlayQueue::getQueue Dec 12 13:31:43 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:43 volumio2b kernel: usb 1-1.4: new high-speed USB device number 33 using dwc_otg Dec 12 13:31:43 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:43 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:43 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:43 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:43 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:43 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:43 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:43 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:43 volumio2b kernel: usb 1-1.4: New USB device found, idVendor=054c, idProduct=0899, bcdDevice= 1.00 Dec 12 13:31:43 volumio2b kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 12 13:31:43 volumio2b kernel: usb 1-1.4: Product: Sony Audio Dec 12 13:31:43 volumio2b kernel: usb 1-1.4: Manufacturer: Sony Dec 12 13:31:43 volumio2b kernel: usb 1-1.4: SerialNumber: 70C94E2538F9 Dec 12 13:31:43 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to retrieve number of sample rates (clock 41) Dec 12 13:31:44 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:44 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:44 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:44 volumio2b kernel: usb 1-1.4: USB disconnect, device number 33 Dec 12 13:31:44 volumio2b systemd-udevd[1630]: error opening ATTR{/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/sound/card5/controlC5/../uevent} for writing: No such file or directory Dec 12 13:31:44 volumio2b systemd-udevd[1630]: Failed to apply ACL on /dev/snd/controlC5: No such file or directory Dec 12 13:31:44 volumio2b volumio[803]: info: Dec 12 13:31:44 volumio2b volumio[803]: ---------------------------- USB Audio Device Attached Dec 12 13:31:44 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 12 13:31:44 volumio2b systemd-udevd[1628]: Failed to apply ACL on /dev/snd/pcmC5D0p: No such file or directory Dec 12 13:31:44 volumio2b volumio[803]: info: Dec 12 13:31:44 volumio2b volumio[803]: ---------------------------- USB Audio Device Detached Dec 12 13:31:44 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 12 13:31:44 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 13:31:44 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:44 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:44 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:44 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:44 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:44 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:44 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:44 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:45 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:45 volumio2b kernel: usb 1-1.4: new high-speed USB device number 35 using dwc_otg Dec 12 13:31:45 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:45 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:45 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:45 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:45 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:45 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:45 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:45 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:46 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:46 volumio2b kernel: usb 1-1-port4: attempt power cycle Dec 12 13:31:46 volumio2b kernel: usb 1-1.4: new high-speed USB device number 36 using dwc_otg Dec 12 13:31:46 volumio2b systemd[1]: Starting Raspberry Pi temperature textfile collector... Dec 12 13:31:46 volumio2b systemd[1649]: Failed at step EXEC spawning /usr/local/bin/rpi_temp_collector.sh: Exec format error Dec 12 13:31:46 volumio2b systemd[1]: rpi-temp-collector.service: main process exited, code=exited, status=203/EXEC Dec 12 13:31:46 volumio2b systemd[1]: Failed to start Raspberry Pi temperature textfile collector. Dec 12 13:31:46 volumio2b systemd[1]: Unit rpi-temp-collector.service entered failed state. Dec 12 13:31:46 volumio2b kernel: usb 1-1.4: device descriptor read/8, error -71 Dec 12 13:31:46 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:46 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:46 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:46 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:46 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:46 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:46 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:46 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:46 volumio2b kernel: usb 1-1.4: device descriptor read/8, error -71 Dec 12 13:31:47 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:47 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:47 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:47 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:47 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:47 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:47 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:47 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:48 volumio2b kernel: usb 1-1.4: new high-speed USB device number 37 using dwc_otg Dec 12 13:31:48 volumio2b kernel: usb 1-1.4: device descriptor read/8, error -71 Dec 12 13:31:48 volumio2b kernel: usb 1-1.4: device descriptor read/8, error -71 Dec 12 13:31:48 volumio2b kernel: usb 1-1-port4: unable to enumerate USB device Dec 12 13:31:48 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:48 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:48 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:48 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:48 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:48 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:48 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:48 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:49 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:49 volumio2b kernel: usb 1-1.4: new high-speed USB device number 39 using dwc_otg Dec 12 13:31:49 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:49 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:49 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:49 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:49 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:49 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:49 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:49 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:50 volumio2b kernel: usb 1-1.4: device descriptor read/64, error -71 Dec 12 13:31:50 volumio2b kernel: usb 1-1.4: New USB device found, idVendor=054c, idProduct=0899, bcdDevice= 1.00 Dec 12 13:31:50 volumio2b kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 12 13:31:50 volumio2b kernel: usb 1-1.4: Product: Sony Audio Dec 12 13:31:50 volumio2b kernel: usb 1-1.4: Manufacturer: Sony Dec 12 13:31:50 volumio2b kernel: usb 1-1.4: SerialNumber: 70C94E2538F9 Dec 12 13:31:50 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:50 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:50 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:50 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:50 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:50 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:50 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:50 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:50 volumio2b kernel: usb 1-1.4: uac_clock_source_is_valid(): cannot get clock validity for id 41 Dec 12 13:31:50 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:50 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:50 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:31:50 volumio2b kernel: usb 1-1.4: USB disconnect, device number 39 Dec 12 13:31:50 volumio2b systemd-udevd[1661]: error opening ATTR{/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/sound/card5/controlC5/../uevent} for writing: No such file or directory Dec 12 13:31:51 volumio2b systemd-udevd[1661]: Failed to apply ACL on /dev/snd/controlC5: No such file or directory Dec 12 13:31:51 volumio2b volumio[803]: info: Dec 12 13:31:51 volumio2b volumio[803]: ---------------------------- USB Audio Device Attached Dec 12 13:31:51 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 12 13:31:51 volumio2b systemd-udevd[1660]: Failed to apply ACL on /dev/snd/pcmC5D0p: No such file or directory Dec 12 13:31:51 volumio2b volumio[803]: info: Dec 12 13:31:51 volumio2b volumio[803]: ---------------------------- USB Audio Device Detached Dec 12 13:31:51 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 12 13:31:51 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 13:31:51 volumio2b kernel: usb 1-1.4: new high-speed USB device number 40 using dwc_otg Dec 12 13:31:51 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:51 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:51 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:51 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:51 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:51 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:51 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:51 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:52 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:52 volumio2b kernel: usb 1-1.4: new high-speed USB device number 41 using dwc_otg Dec 12 13:31:52 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:52 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:52 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:52 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:52 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:52 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:52 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:52 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:53 volumio2b kernel: usb 1-1.4: device descriptor read/64, error -71 Dec 12 13:31:53 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:53 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:53 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:53 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:53 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:53 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:53 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:53 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:54 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:54 volumio2b kernel: usb 1-1-port4: attempt power cycle Dec 12 13:31:54 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:54 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:54 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:54 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:54 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:54 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:54 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:54 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:55 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 12 13:31:55 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:55 volumio2b kernel: usb 1-1.4: new high-speed USB device number 43 using dwc_otg Dec 12 13:31:55 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:55 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:55 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:55 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:55 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:55 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:55 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:55 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:56 volumio2b kernel: usb 1-1.4: device not accepting address 43, error -71 Dec 12 13:31:56 volumio2b kernel: usb 1-1-port4: unable to enumerate USB device Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 12 13:31:56 volumio2b volumio[803]: info: Retrieving Cloud Streaming UI Dec 12 13:31:56 volumio2b kernel: usb 1-1.4: new high-speed USB device number 44 using dwc_otg Dec 12 13:31:56 volumio2b volumio[803]: info: Getting Tidal Cloud Configuration Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 12 13:31:56 volumio2b volumio[803]: info: Getting Qobuz Cloud Configuration Dec 12 13:31:56 volumio2b volumio[803]: info: Asking plugin for UI Config Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 12 13:31:56 volumio2b volumio[803]: info: Getting Spotify Cloud Configuration Dec 12 13:31:56 volumio2b volumio[803]: info: Asking plugin for UI Config Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 12 13:31:56 volumio2b volumio[803]: info: Saving Spotify Acccount Dec 12 13:31:56 volumio2b volumio[803]: info: Got Tidal Cloud Configuration Dec 12 13:31:56 volumio2b volumio[803]: info: Got it Dec 12 13:31:56 volumio2b volumio[803]: info: Got it Dec 12 13:31:56 volumio2b volumio[803]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 12 13:31:56 volumio2b volumio[803]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::volumioGetBrowseSources Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:56 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:56 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 12 13:31:56 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 12 13:31:57 volumio2b kernel: usb 1-1.4: device descriptor read/64, error -71 Dec 12 13:31:57 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:57 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:57 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:57 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:57 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:57 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:57 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:57 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:58 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:31:58 volumio2b kernel: usb 1-1.4: new high-speed USB device number 45 using dwc_otg Dec 12 13:31:58 volumio2b kernel: usb 1-1.4: New USB device found, idVendor=054c, idProduct=0899, bcdDevice= 1.00 Dec 12 13:31:58 volumio2b kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 12 13:31:58 volumio2b kernel: usb 1-1.4: Product: Sony Audio Dec 12 13:31:58 volumio2b kernel: usb 1-1.4: Manufacturer: Sony Dec 12 13:31:58 volumio2b kernel: usb 1-1.4: SerialNumber: 70C94E2538F9 Dec 12 13:31:58 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:58 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:58 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:58 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:58 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:58 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:58 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:58 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:59 volumio2b volumio[803]: info: Dec 12 13:31:59 volumio2b volumio[803]: ---------------------------- USB Audio Device Attached Dec 12 13:31:59 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 12 13:31:59 volumio2b kernel: usb 1-1.4: USB disconnect, device number 45 Dec 12 13:31:59 volumio2b volumio[803]: info: Dec 12 13:31:59 volumio2b volumio[803]: ---------------------------- USB Audio Device Detached Dec 12 13:31:59 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 12 13:31:59 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 13:31:59 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:59 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:59 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:59 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:31:59 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:31:59 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:31:59 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:31:59 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:00 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:32:00 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 12 13:32:00 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:00 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:00 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:00 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:00 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:00 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:00 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:00 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:01 volumio2b kernel: usb 1-1.4: new high-speed USB device number 47 using dwc_otg Dec 12 13:32:01 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:01 volumio2b systemd[1]: Starting Raspberry Pi temperature textfile collector... Dec 12 13:32:01 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:01 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:01 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:01 volumio2b systemd[1702]: Failed at step EXEC spawning /usr/local/bin/rpi_temp_collector.sh: Exec format error Dec 12 13:32:01 volumio2b systemd[1]: rpi-temp-collector.service: main process exited, code=exited, status=203/EXEC Dec 12 13:32:01 volumio2b systemd[1]: Failed to start Raspberry Pi temperature textfile collector. Dec 12 13:32:01 volumio2b systemd[1]: Unit rpi-temp-collector.service entered failed state. Dec 12 13:32:01 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:01 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:01 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:01 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:02 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:32:02 volumio2b kernel: usb 1-1-port4: attempt power cycle Dec 12 13:32:02 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:02 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:02 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:02 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:02 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:02 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:02 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:02 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:03 volumio2b kernel: usb 1-1.4: new high-speed USB device number 48 using dwc_otg Dec 12 13:32:03 volumio2b kernel: usb 1-1.4: New USB device found, idVendor=054c, idProduct=0899, bcdDevice= 1.00 Dec 12 13:32:03 volumio2b kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 12 13:32:03 volumio2b kernel: usb 1-1.4: Product: Sony Audio Dec 12 13:32:03 volumio2b kernel: usb 1-1.4: Manufacturer: Sony Dec 12 13:32:03 volumio2b kernel: usb 1-1.4: SerialNumber: 70C94E2538F9 Dec 12 13:32:03 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:32:03 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:32:03 volumio2b kernel: usb 1-1.4: USB disconnect, device number 48 Dec 12 13:32:03 volumio2b systemd-udevd[1708]: error opening ATTR{/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/sound/card5/controlC5/../uevent} for writing: No such file or directory Dec 12 13:32:03 volumio2b systemd-udevd[1708]: Failed to apply ACL on /dev/snd/controlC5: No such file or directory Dec 12 13:32:03 volumio2b volumio[803]: info: Dec 12 13:32:03 volumio2b volumio[803]: ---------------------------- USB Audio Device Attached Dec 12 13:32:03 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 12 13:32:03 volumio2b systemd-udevd[1706]: Failed to apply ACL on /dev/snd/pcmC5D0p: No such file or directory Dec 12 13:32:03 volumio2b volumio[803]: info: Dec 12 13:32:03 volumio2b volumio[803]: ---------------------------- USB Audio Device Detached Dec 12 13:32:03 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 12 13:32:03 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 13:32:03 volumio2b kernel: usb 1-1.4: new high-speed USB device number 49 using dwc_otg Dec 12 13:32:03 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:03 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:03 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:03 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:03 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:03 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:03 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:03 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:04 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:32:04 volumio2b kernel: usb 1-1.4: new high-speed USB device number 50 using dwc_otg Dec 12 13:32:04 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 12 13:32:04 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:04 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:04 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:04 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:04 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:04 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:04 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:04 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:05 volumio2b kernel: usb 1-1.4: device not accepting address 50, error -71 Dec 12 13:32:05 volumio2b kernel: usb 1-1-port4: attempt power cycle Dec 12 13:32:05 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:05 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:05 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:05 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:05 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:05 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:05 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:05 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:06 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:32:06 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:06 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:06 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:06 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:06 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:06 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:06 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:06 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:07 volumio2b kernel: usb 1-1.4: new high-speed USB device number 52 using dwc_otg Dec 12 13:32:07 volumio2b kernel: usb 1-1.4: New USB device found, idVendor=054c, idProduct=0899, bcdDevice= 1.00 Dec 12 13:32:07 volumio2b kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 12 13:32:07 volumio2b kernel: usb 1-1.4: Product: Sony Audio Dec 12 13:32:07 volumio2b kernel: usb 1-1.4: Manufacturer: Sony Dec 12 13:32:07 volumio2b kernel: usb 1-1.4: SerialNumber: 70C94E2538F9 Dec 12 13:32:07 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:32:07 volumio2b kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to find clock source (clock -71) Dec 12 13:32:07 volumio2b kernel: usb 1-1.4: USB disconnect, device number 52 Dec 12 13:32:07 volumio2b systemd-udevd[1724]: error opening ATTR{/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/sound/card5/controlC5/../uevent} for writing: No such file or directory Dec 12 13:32:07 volumio2b systemd-udevd[1724]: Failed to apply ACL on /dev/snd/controlC5: No such file or directory Dec 12 13:32:07 volumio2b volumio[803]: info: Dec 12 13:32:07 volumio2b volumio[803]: ---------------------------- USB Audio Device Attached Dec 12 13:32:07 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 12 13:32:07 volumio2b systemd-udevd[1722]: Failed to apply ACL on /dev/snd/pcmC5D0p: No such file or directory Dec 12 13:32:07 volumio2b volumio[803]: info: Dec 12 13:32:07 volumio2b volumio[803]: ---------------------------- USB Audio Device Detached Dec 12 13:32:07 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 12 13:32:07 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 13:32:07 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:07 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:07 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:07 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:07 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:07 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:07 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:07 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:07 volumio2b kernel: usb 1-1.4: new high-speed USB device number 53 using dwc_otg Dec 12 13:32:08 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:32:08 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 12 13:32:08 volumio2b kernel: usb 1-1.4: new high-speed USB device number 54 using dwc_otg Dec 12 13:32:08 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:08 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:08 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:08 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:08 volumio2b volumio[803]: info: CoreCommandRouter::servicePushState Dec 12 13:32:08 volumio2b volumio[803]: info: CoreStateMachine::pushState Dec 12 13:32:08 volumio2b volumio[803]: info: CoreCommandRouter::volumioPushState Dec 12 13:32:08 volumio2b volumio[803]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 13:32:09 volumio2b kernel: usb 1-1.4: device not accepting address 54, error -71 Dec 12 13:32:09 volumio2b kernel: usb 1-1-port4: attempt power cycle Dec 12 13:32:09 volumio2b volumio[803]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 12 13:32:09 volumio2b volumio[803]: { Error: connect ETIMEDOUT 69.63.184.30:443 Dec 12 13:32:09 volumio2b volumio[803]: at Object._errnoException (util.js:1022:11) Dec 12 13:32:09 volumio2b volumio[803]: at _exceptionWithHostPort (util.js:1044:20) Dec 12 13:32:09 volumio2b volumio[803]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Dec 12 13:32:09 volumio2b volumio[803]: code: 'ETIMEDOUT', Dec 12 13:32:09 volumio2b volumio[803]: errno: 'ETIMEDOUT', Dec 12 13:32:09 volumio2b volumio[803]: syscall: 'connect', Dec 12 13:32:09 volumio2b volumio[803]: address: '69.63.184.30', Dec 12 13:32:09 volumio2b volumio[803]: port: 443 } Dec 12 13:32:09 volumio2b volumio[803]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 12 13:32:10 volumio2b kernel: usb 1-1-port4: Cannot enable. Maybe the USB cable is bad? Dec 12 13:32:11 volumio2b sudo[1742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-12 13:31 Dec 12 13:32:11 volumio2b sudo[1742]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"