Sun Apr 7 21:55:09 CEST 2024 Description="'Weather info not loading on Now Playing idle screen'" # cat /proc/version --------------- Linux version 6.1.69-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1710 SMP Thu Dec 21 13:17:38 GMT 2023 # cat /etc/os-release --------------- PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b" # ifconfig --------------- eth0: flags=4099 mtu 1500 ether dc:a6:32:6c:7a:fc txqueuelen 1000 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 0 bytes 0 (0.0 B) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 lo: flags=73 mtu 65536 inet 127.0.0.1 netmask 255.0.0.0 loop txqueuelen 1000 (Local Loopback) RX packets 1041 bytes 279291 (272.7 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 1041 bytes 279291 (272.7 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 wlan0: flags=4163 mtu 1500 inet 192.168.178.227 netmask 255.255.255.0 broadcast 192.168.178.255 ether dc:a6:32:6c:7a:fd txqueuelen 1000 (Ethernet) RX packets 2613 bytes 977708 (954.7 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 1744 bytes 299699 (292.6 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 # sudo iwconfig --------------- lo no wireless extensions. eth0 no wireless extensions. wlan0 IEEE 802.11 ESSID:"Ziggy" Mode:Managed Frequency:5.24 GHz Access Point: AC:22:05:46:79:F1 Bit Rate=325 Mb/s Tx-Power=31 dBm Retry short limit:7 RTS thr:off Fragment thr:off Encryption key:off Power Management:off Link Quality=47/70 Signal level=-63 dBm Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:0 Tx excessive retries:3 Invalid misc:0 Missed beacon:0 # aplay -l --------------- **** List of PLAYBACK Hardware Devices **** card 0: Headphones [bcm2835 Headphones], device 0: bcm2835 Headphones [bcm2835 Headphones] Subdevices: 8/8 Subdevice #0: subdevice #0 Subdevice #1: subdevice #1 Subdevice #2: subdevice #2 Subdevice #3: subdevice #3 Subdevice #4: subdevice #4 Subdevice #5: subdevice #5 Subdevice #6: subdevice #6 Subdevice #7: subdevice #7 card 5: D10s [D10s], device 0: USB Audio [USB Audio] Subdevices: 1/1 Subdevice #0: subdevice #0 # lsusb --------------- Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub Bus 001 Device 003: ID 152a:8750 Thesycon Systemsoftware & Consulting GmbH Bus 001 Device 002: ID 2109:3431 VIA Labs, Inc. Hub Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub # lsusb -t --------------- /: Bus 02.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/4p, 5000M /: Bus 01.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/1p, 480M |__ Port 1: Dev 2, If 0, Class=Hub, Driver=hub/4p, 480M |__ Port 1: Dev 3, If 0, Class=Audio, Driver=snd-usb-audio, 480M |__ Port 1: Dev 3, If 1, Class=Audio, Driver=snd-usb-audio, 480M |__ Port 1: Dev 3, If 2, Class=Application Specific Interface, Driver=, 480M # lsusb -v --------------- Couldn't open device, some information will be missing Couldn't open device, some information will be missing Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub Device Descriptor: bLength 18 bDescriptorType 1 bcdUSB 3.00 bDeviceClass 9 Hub bDeviceSubClass 0 bDeviceProtocol 3 bMaxPacketSize0 9 idVendor 0x1d6b Linux Foundation idProduct 0x0003 3.0 root hub bcdDevice 6.01 iManufacturer 3 iProduct 2 iSerial 1 bNumConfigurations 1 Configuration Descriptor: bLength 9 bDescriptorType 2 wTotalLength 0x001f bNumInterfaces 1 bConfigurationValue 1 iConfiguration 0 bmAttributes 0xe0 Self Powered Remote Wakeup MaxPower 0mA Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 0 bAlternateSetting 0 bNumEndpoints 1 bInterfaceClass 9 Hub bInterfaceSubClass 0 bInterfaceProtocol 0 Full speed (or root) hub iInterface 0 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x81 EP 1 IN bmAttributes 3 Transfer Type Interrupt Synch Type None Usage Type Data wMaxPacketSize 0x0004 1x 4 bytes bInterval 12 bMaxBurst 0 Bus 001 Device 003: ID 152a:8750 Thesycon Systemsoftware & Consulting GmbH Device Descriptor: bLength 18 bDescriptorType 1 bcdUSB 2.00 bDeviceClass 239 Miscellaneous Device bDeviceSubClass 2 bDeviceProtocol 1 Interface Association bMaxPacketSize0 64 idVendor 0x152a Thesycon Systemsoftware & Consulting GmbH idProduct 0x8750 bcdDevice 1.04 iManufacturer 1 iProduct 3 iSerial 0 bNumConfigurations 2 Configuration Descriptor: bLength 9 bDescriptorType 2 wTotalLength 0x011c bNumInterfaces 3 bConfigurationValue 1 iConfiguration 0 bmAttributes 0x80 (Bus Powered) MaxPower 0mA Interface Association: bLength 8 bDescriptorType 11 bFirstInterface 0 bInterfaceCount 2 bFunctionClass 1 Audio bFunctionSubClass 0 bFunctionProtocol 32 iFunction 0 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 0 bAlternateSetting 0 bNumEndpoints 0 bInterfaceClass 1 Audio bInterfaceSubClass 1 Control Device bInterfaceProtocol 32 iInterface 3 AudioControl Interface Descriptor: bLength 9 bDescriptorType 36 bDescriptorSubtype 1 (HEADER) bcdADC 2.00 bCategory 8 wTotalLength 0x0048 bmControls 0x00 AudioControl Interface Descriptor: bLength 8 bDescriptorType 36 bDescriptorSubtype 10 (CLOCK_SOURCE) bClockID 41 bmAttributes 3 Internal programmable clock bmControls 0x07 Clock Frequency Control (read/write) Clock Validity Control (read-only) bAssocTerminal 0 iClockSource 9 AudioControl Interface Descriptor: bLength 8 bDescriptorType 36 bDescriptorSubtype 11 (CLOCK_SELECTOR) bClockID 40 bNrInPins 1 baCSourceID(0) 41 bmControls 0x03 Clock Selector Control (read/write) iClockSelector 8 AudioControl Interface Descriptor: bLength 17 bDescriptorType 36 bDescriptorSubtype 2 (INPUT_TERMINAL) bTerminalID 2 wTerminalType 0x0101 USB Streaming bAssocTerminal 0 bCSourceID 40 bNrChannels 2 bmChannelConfig 0x00000000 iChannelNames 11 bmControls 0x0000 iTerminal 6 AudioControl Interface Descriptor: bLength 18 bDescriptorType 36 bDescriptorSubtype 6 (FEATURE_UNIT) bUnitID 10 bSourceID 2 bmaControls(0) 0x0000000f Mute Control (read/write) Volume Control (read/write) bmaControls(1) 0x00000000 bmaControls(2) 0x00000000 iFeature 0 AudioControl Interface Descriptor: bLength 12 bDescriptorType 36 bDescriptorSubtype 3 (OUTPUT_TERMINAL) bTerminalID 20 wTerminalType 0x0301 Speaker bAssocTerminal 0 bSourceID 10 bCSourceID 40 bmControls 0x0000 iTerminal 0 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 1 bAlternateSetting 0 bNumEndpoints 0 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 32 iInterface 4 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 1 bAlternateSetting 1 bNumEndpoints 2 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 32 iInterface 4 AudioStreaming Interface Descriptor: bLength 16 bDescriptorType 36 bDescriptorSubtype 1 (AS_GENERAL) bTerminalLink 2 bmControls 0x00 bFormatType 1 bmFormats 0x00000001 PCM bNrChannels 2 bmChannelConfig 0x00000000 iChannelNames 11 AudioStreaming Interface Descriptor: bLength 6 bDescriptorType 36 bDescriptorSubtype 2 (FORMAT_TYPE) bFormatType 1 (FORMAT_TYPE_I) bSubslotSize 4 bBitResolution 32 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x01 EP 1 OUT bmAttributes 5 Transfer Type Isochronous Synch Type Asynchronous Usage Type Data wMaxPacketSize 0x0188 1x 392 bytes bInterval 1 AudioStreaming Endpoint Descriptor: bLength 8 bDescriptorType 37 bDescriptorSubtype 1 (EP_GENERAL) bmAttributes 0x00 bmControls 0x00 bLockDelayUnits 2 Decoded PCM samples wLockDelay 0x0008 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x81 EP 1 IN bmAttributes 17 Transfer Type Isochronous Synch Type None Usage Type Feedback wMaxPacketSize 0x0004 1x 4 bytes bInterval 4 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 1 bAlternateSetting 2 bNumEndpoints 2 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 32 iInterface 4 AudioStreaming Interface Descriptor: bLength 16 bDescriptorType 36 bDescriptorSubtype 1 (AS_GENERAL) bTerminalLink 2 bmControls 0x00 bFormatType 1 bmFormats 0x00000001 PCM bNrChannels 2 bmChannelConfig 0x00000000 iChannelNames 11 AudioStreaming Interface Descriptor: bLength 6 bDescriptorType 36 bDescriptorSubtype 2 (FORMAT_TYPE) bFormatType 1 (FORMAT_TYPE_I) bSubslotSize 4 bBitResolution 24 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x01 EP 1 OUT bmAttributes 5 Transfer Type Isochronous Synch Type Asynchronous Usage Type Data wMaxPacketSize 0x0188 1x 392 bytes bInterval 1 AudioStreaming Endpoint Descriptor: bLength 8 bDescriptorType 37 bDescriptorSubtype 1 (EP_GENERAL) bmAttributes 0x00 bmControls 0x00 bLockDelayUnits 2 Decoded PCM samples wLockDelay 0x0008 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x81 EP 1 IN bmAttributes 17 Transfer Type Isochronous Synch Type None Usage Type Feedback wMaxPacketSize 0x0004 1x 4 bytes bInterval 4 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 1 bAlternateSetting 3 bNumEndpoints 2 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 32 iInterface 4 AudioStreaming Interface Descriptor: bLength 16 bDescriptorType 36 bDescriptorSubtype 1 (AS_GENERAL) bTerminalLink 2 bmControls 0x00 bFormatType 1 bmFormats 0x80000000 bNrChannels 2 bmChannelConfig 0x00000000 iChannelNames 11 AudioStreaming Interface Descriptor: bLength 6 bDescriptorType 36 bDescriptorSubtype 2 (FORMAT_TYPE) bFormatType 1 (FORMAT_TYPE_I) bSubslotSize 4 bBitResolution 32 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x01 EP 1 OUT bmAttributes 5 Transfer Type Isochronous Synch Type Asynchronous Usage Type Data wMaxPacketSize 0x0188 1x 392 bytes bInterval 1 AudioStreaming Endpoint Descriptor: bLength 8 bDescriptorType 37 bDescriptorSubtype 1 (EP_GENERAL) bmAttributes 0x00 bmControls 0x00 bLockDelayUnits 2 Decoded PCM samples wLockDelay 0x0008 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x81 EP 1 IN bmAttributes 17 Transfer Type Isochronous Synch Type None Usage Type Feedback wMaxPacketSize 0x0004 1x 4 bytes bInterval 4 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 2 bAlternateSetting 0 bNumEndpoints 0 bInterfaceClass 254 Application Specific Interface bInterfaceSubClass 1 Device Firmware Update bInterfaceProtocol 1 iInterface 10 Device Firmware Upgrade Interface Descriptor: bLength 9 bDescriptorType 33 bmAttributes 7 Will Not Detach Manifestation Tolerant Upload Supported Download Supported wDetachTimeout 250 milliseconds wTransferSize 64 bytes bcdDFUVersion 1.10 Configuration Descriptor: bLength 9 bDescriptorType 2 wTotalLength 0x011c bNumInterfaces 3 bConfigurationValue 1 iConfiguration 0 bmAttributes 0x80 (Bus Powered) MaxPower 0mA Interface Association: bLength 8 bDescriptorType 11 bFirstInterface 0 bInterfaceCount 2 bFunctionClass 1 Audio bFunctionSubClass 0 bFunctionProtocol 32 iFunction 0 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 0 bAlternateSetting 0 bNumEndpoints 0 bInterfaceClass 1 Audio bInterfaceSubClass 1 Control Device bInterfaceProtocol 32 iInterface 3 AudioControl Interface Descriptor: bLength 9 bDescriptorType 36 bDescriptorSubtype 1 (HEADER) bcdADC 2.00 bCategory 8 wTotalLength 0x0048 bmControls 0x00 AudioControl Interface Descriptor: bLength 8 bDescriptorType 36 bDescriptorSubtype 10 (CLOCK_SOURCE) bClockID 41 bmAttributes 3 Internal programmable clock bmControls 0x07 Clock Frequency Control (read/write) Clock Validity Control (read-only) bAssocTerminal 0 iClockSource 9 AudioControl Interface Descriptor: bLength 8 bDescriptorType 36 bDescriptorSubtype 11 (CLOCK_SELECTOR) bClockID 40 bNrInPins 1 baCSourceID(0) 41 bmControls 0x03 Clock Selector Control (read/write) iClockSelector 8 AudioControl Interface Descriptor: bLength 17 bDescriptorType 36 bDescriptorSubtype 2 (INPUT_TERMINAL) bTerminalID 2 wTerminalType 0x0101 USB Streaming bAssocTerminal 0 bCSourceID 40 bNrChannels 2 bmChannelConfig 0x00000000 iChannelNames 11 bmControls 0x0000 iTerminal 6 AudioControl Interface Descriptor: bLength 18 bDescriptorType 36 bDescriptorSubtype 6 (FEATURE_UNIT) bUnitID 10 bSourceID 2 bmaControls(0) 0x0000000f Mute Control (read/write) Volume Control (read/write) bmaControls(1) 0x00000000 bmaControls(2) 0x00000000 iFeature 0 AudioControl Interface Descriptor: bLength 12 bDescriptorType 36 bDescriptorSubtype 3 (OUTPUT_TERMINAL) bTerminalID 20 wTerminalType 0x0301 Speaker bAssocTerminal 0 bSourceID 10 bCSourceID 40 bmControls 0x0000 iTerminal 0 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 1 bAlternateSetting 0 bNumEndpoints 0 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 32 iInterface 4 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 1 bAlternateSetting 1 bNumEndpoints 2 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 32 iInterface 4 AudioStreaming Interface Descriptor: bLength 16 bDescriptorType 36 bDescriptorSubtype 1 (AS_GENERAL) bTerminalLink 2 bmControls 0x00 bFormatType 1 bmFormats 0x00000001 PCM bNrChannels 2 bmChannelConfig 0x00000000 iChannelNames 11 AudioStreaming Interface Descriptor: bLength 6 bDescriptorType 36 bDescriptorSubtype 2 (FORMAT_TYPE) bFormatType 1 (FORMAT_TYPE_I) bSubslotSize 4 bBitResolution 32 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x01 EP 1 OUT bmAttributes 5 Transfer Type Isochronous Synch Type Asynchronous Usage Type Data wMaxPacketSize 0x0188 1x 392 bytes bInterval 1 AudioStreaming Endpoint Descriptor: bLength 8 bDescriptorType 37 bDescriptorSubtype 1 (EP_GENERAL) bmAttributes 0x00 bmControls 0x00 bLockDelayUnits 2 Decoded PCM samples wLockDelay 0x0008 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x81 EP 1 IN bmAttributes 17 Transfer Type Isochronous Synch Type None Usage Type Feedback wMaxPacketSize 0x0004 1x 4 bytes bInterval 4 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 1 bAlternateSetting 2 bNumEndpoints 2 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 32 iInterface 4 AudioStreaming Interface Descriptor: bLength 16 bDescriptorType 36 bDescriptorSubtype 1 (AS_GENERAL) bTerminalLink 2 bmControls 0x00 bFormatType 1 bmFormats 0x00000001 PCM bNrChannels 2 bmChannelConfig 0x00000000 iChannelNames 11 AudioStreaming Interface Descriptor: bLength 6 bDescriptorType 36 bDescriptorSubtype 2 (FORMAT_TYPE) bFormatType 1 (FORMAT_TYPE_I) bSubslotSize 4 bBitResolution 24 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x01 EP 1 OUT bmAttributes 5 Transfer Type Isochronous Synch Type Asynchronous Usage Type Data wMaxPacketSize 0x0188 1x 392 bytes bInterval 1 AudioStreaming Endpoint Descriptor: bLength 8 bDescriptorType 37 bDescriptorSubtype Couldn't open device, some information will be missing 1 (EP_GENERAL) bmAttributes 0x00 bmControls 0x00 bLockDelayUnits 2 Decoded PCM samples wLockDelay 0x0008 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x81 EP 1 IN bmAttributes 17 Transfer Type Isochronous Synch Type None Usage Type Feedback wMaxPacketSize 0x0004 1x 4 bytes bInterval 4 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 1 bAlternateSetting 3 bNumEndpoints 2 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 32 iInterface 4 AudioStreaming Interface Descriptor: bLength 16 bDescriptorType 36 bDescriptorSubtype 1 (AS_GENERAL) bTerminalLink 2 bmControls 0x00 bFormatType 1 bmFormats 0x80000000 bNrChannels 2 bmChannelConfig 0x00000000 iChannelNames 11 AudioStreaming Interface Descriptor: bLength 6 bDescriptorType 36 bDescriptorSubtype 2 (FORMAT_TYPE) bFormatType 1 (FORMAT_TYPE_I) bSubslotSize 4 bBitResolution 32 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x01 EP 1 OUT bmAttributes 5 Transfer Type Isochronous Synch Type Asynchronous Usage Type Data wMaxPacketSize 0x0188 1x 392 bytes bInterval 1 AudioStreaming Endpoint Descriptor: bLength 8 bDescriptorType 37 bDescriptorSubtype 1 (EP_GENERAL) bmAttributes 0x00 bmControls 0x00 bLockDelayUnits 2 Decoded PCM samples wLockDelay 0x0008 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x81 EP 1 IN bmAttributes 17 Transfer Type Isochronous Synch Type None Usage Type Feedback wMaxPacketSize 0x0004 1x 4 bytes bInterval 4 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 2 bAlternateSetting 0 bNumEndpoints 0 bInterfaceClass 254 Application Specific Interface bInterfaceSubClass 1 Device Firmware Update bInterfaceProtocol 1 iInterface 10 Device Firmware Upgrade Interface Descriptor: bLength 9 bDescriptorType 33 bmAttributes 7 Will Not Detach Manifestation Tolerant Upload Supported Download Supported wDetachTimeout 250 milliseconds wTransferSize 64 bytes bcdDFUVersion 1.10 Bus 001 Device 002: ID 2109:3431 VIA Labs, Inc. Hub Device Descriptor: bLength 18 bDescriptorType 1 bcdUSB 2.10 bDeviceClass 9 Hub bDeviceSubClass 0 bDeviceProtocol 1 Single TT bMaxPacketSize0 64 idVendor 0x2109 VIA Labs, Inc. idProduct 0x3431 Hub bcdDevice 4.21 iManufacturer 0 iProduct 1 iSerial 0 bNumConfigurations 1 Configuration Descriptor: bLength 9 bDescriptorType Couldn't open device, some information will be missing 2 wTotalLength 0x0019 bNumInterfaces 1 bConfigurationValue 1 iConfiguration 0 bmAttributes 0xe0 Self Powered Remote Wakeup MaxPower 100mA Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 0 bAlternateSetting 0 bNumEndpoints 1 bInterfaceClass 9 Hub bInterfaceSubClass 0 bInterfaceProtocol 0 Full speed (or root) hub iInterface 0 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x81 EP 1 IN bmAttributes 3 Transfer Type Interrupt Synch Type None Usage Type Data wMaxPacketSize 0x0001 1x 1 bytes bInterval 12 Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub Device Descriptor: bLength 18 bDescriptorType 1 bcdUSB 2.00 bDeviceClass 9 Hub bDeviceSubClass 0 bDeviceProtocol 1 Single TT bMaxPacketSize0 64 idVendor 0x1d6b Linux Foundation idProduct 0x0002 2.0 root hub bcdDevice 6.01 iManufacturer 3 iProduct 2 iSerial 1 bNumConfigurations 1 Configuration Descriptor: bLength 9 bDescriptorType 2 wTotalLength 0x0019 bNumInterfaces 1 bConfigurationValue 1 iConfiguration 0 bmAttributes 0xe0 Self Powered Remote Wakeup MaxPower 0mA Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 0 bAlternateSetting 0 bNumEndpoints 1 bInterfaceClass 9 Hub bInterfaceSubClass 0 bInterfaceProtocol 0 Full speed (or root) hub iInterface 0 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x81 EP 1 IN bmAttributes 3 Transfer Type Interrupt Synch Type None Usage Type Data wMaxPacketSize 0x0004 1x 4 bytes bInterval 12 # ps -ef --------------- UID PID PPID C STIME TTY TIME CMD root 1 0 3 21:51 ? 00:00:06 /sbin/init root 2 0 0 21:51 ? 00:00:00 [kthreadd] root 3 2 0 21:51 ? 00:00:00 [rcu_gp] root 4 2 0 21:51 ? 00:00:00 [rcu_par_gp] root 5 2 0 21:51 ? 00:00:00 [slub_flushwq] root 6 2 0 21:51 ? 00:00:00 [netns] root 7 2 0 21:51 ? 00:00:00 [kworker/0:0-events] root 8 2 0 21:51 ? 00:00:00 [kworker/0:0H-mmc_complete] root 9 2 0 21:51 ? 00:00:01 [kworker/u8:0-loop0] root 10 2 0 21:51 ? 00:00:00 [mm_percpu_wq] root 11 2 0 21:51 ? 00:00:00 [rcu_tasks_rude_kthread] root 12 2 0 21:51 ? 00:00:00 [rcu_tasks_trace_kthread] root 13 2 0 21:51 ? 00:00:00 [ksoftirqd/0] root 14 2 0 21:51 ? 00:00:00 [rcu_sched] root 15 2 0 21:51 ? 00:00:00 [migration/0] root 16 2 0 21:51 ? 00:00:00 [cpuhp/0] root 17 2 0 21:51 ? 00:00:00 [cpuhp/1] root 18 2 0 21:51 ? 00:00:00 [migration/1] root 19 2 0 21:51 ? 00:00:00 [ksoftirqd/1] root 20 2 0 21:51 ? 00:00:00 [kworker/1:0-events_freezable] root 21 2 0 21:51 ? 00:00:00 [kworker/1:0H-kblockd] root 22 2 0 21:51 ? 00:00:00 [cpuhp/2] root 23 2 0 21:51 ? 00:00:00 [migration/2] root 24 2 0 21:51 ? 00:00:00 [ksoftirqd/2] root 25 2 0 21:51 ? 00:00:00 [kworker/2:0-mm_percpu_wq] root 26 2 0 21:51 ? 00:00:00 [kworker/2:0H-events_highpri] root 27 2 0 21:51 ? 00:00:00 [cpuhp/3] root 28 2 0 21:51 ? 00:00:00 [migration/3] root 29 2 0 21:51 ? 00:00:00 [ksoftirqd/3] root 30 2 0 21:51 ? 00:00:00 [kworker/3:0-events] root 31 2 0 21:51 ? 00:00:00 [kworker/3:0H-kblockd] root 32 2 0 21:51 ? 00:00:00 [kdevtmpfs] root 33 2 0 21:51 ? 00:00:00 [inet_frag_wq] root 34 2 0 21:51 ? 00:00:00 [kworker/0:1-events] root 35 2 0 21:51 ? 00:00:00 [kauditd] root 36 2 0 21:51 ? 00:00:00 [khungtaskd] root 37 2 0 21:51 ? 00:00:01 [kworker/u8:1-events_unbound] root 38 2 0 21:51 ? 00:00:00 [oom_reaper] root 39 2 0 21:51 ? 00:00:00 [writeback] root 40 2 0 21:51 ? 00:00:00 [kcompactd0] root 41 2 0 21:51 ? 00:00:00 [kintegrityd] root 42 2 0 21:51 ? 00:00:00 [kblockd] root 43 2 0 21:51 ? 00:00:00 [blkcg_punt_bio] root 44 2 0 21:51 ? 00:00:00 [watchdogd] root 45 2 0 21:51 ? 00:00:00 [kworker/u8:2-events_unbound] root 46 2 0 21:51 ? 00:00:00 [kworker/1:1-cgroup_destroy] root 47 2 0 21:51 ? 00:00:00 [kworker/2:1-events] root 48 2 0 21:51 ? 00:00:00 [kworker/2:1H-kblockd] root 49 2 0 21:51 ? 00:00:00 [rpciod] root 50 2 0 21:51 ? 00:00:00 [xprtiod] root 51 2 0 21:51 ? 00:00:00 [kswapd0] root 52 2 0 21:51 ? 00:00:00 [nfsiod] root 53 2 0 21:51 ? 00:00:00 [kthrotld] root 55 2 0 21:51 ? 00:00:00 [kworker/2:2-events] root 58 2 0 21:51 ? 00:00:00 [kworker/3:1-events_power_efficient] root 59 2 0 21:51 ? 00:00:00 [kworker/3:2-events] root 60 2 0 21:51 ? 00:00:00 [kworker/2:3-cgroup_destroy] root 61 2 0 21:51 ? 00:00:00 [kworker/u8:3-flush-179:0] root 62 2 0 21:51 ? 00:00:00 [hwrng] root 63 2 0 21:51 ? 00:00:00 [iscsi_conn_clea] root 64 2 0 21:51 ? 00:00:00 [nvme-wq] root 65 2 0 21:51 ? 00:00:00 [nvme-reset-wq] root 66 2 0 21:51 ? 00:00:00 [nvme-delete-wq] root 68 2 0 21:51 ? 00:00:00 [DWC Notificatio] root 69 2 0 21:51 ? 00:00:00 [uas] root 70 2 0 21:51 ? 00:00:00 [vchiq-slot/0] root 71 2 0 21:51 ? 00:00:00 [vchiq-recy/0] root 72 2 0 21:51 ? 00:00:00 [vchiq-sync/0] root 73 2 0 21:51 ? 00:00:00 [zswap-shrink] root 74 2 0 21:51 ? 00:00:00 [kworker/u9:0-hci0] root 96 2 0 21:51 ? 00:00:00 [sdhci] root 97 2 0 21:51 ? 00:00:00 [irq/52-mmc0] root 98 2 0 21:51 ? 00:00:00 [kworker/2:4-events] root 106 2 0 21:51 ? 00:00:00 [mmc_complete] root 107 2 0 21:51 ? 00:00:00 [kworker/1:1H-kblockd] root 108 2 0 21:51 ? 00:00:00 [kworker/0:1H-mmc_complete] root 126 2 0 21:51 ? 00:00:00 [kworker/0:2-cgroup_destroy] root 129 2 0 21:51 ? 00:00:00 [kworker/2:2H-kblockd] root 133 2 0 21:51 ? 00:00:00 [kworker/1:2H-kblockd] root 134 2 0 21:51 ? 00:00:00 [kworker/1:2-events] root 135 2 0 21:51 ? 00:00:00 [jbd2/mmcblk0p2-8] root 136 2 0 21:51 ? 00:00:00 [ext4-rsv-conver] root 138 2 0 21:51 ? 00:00:00 [kworker/3:1H-kblockd] root 170 2 0 21:51 ? 00:00:00 [kworker/0:2H-kblockd] root 171 2 0 21:51 ? 00:00:00 [jbd2/mmcblk0p3-8] root 172 2 0 21:51 ? 00:00:00 [ext4-rsv-conver] root 180 2 0 21:51 ? 00:00:00 [kworker/3:2H-kblockd] root 181 2 0 21:52 ? 00:00:00 [mld] root 182 2 0 21:52 ? 00:00:00 [ipv6_addrconf] root 210 1 0 21:52 ? 00:00:00 /lib/systemd/systemd-journald root 218 2 0 21:52 ? 00:00:00 [kworker/2:5-events] root 229 2 0 21:52 ? 00:00:00 [kworker/2:6-events] root 235 1 0 21:52 ? 00:00:00 /lib/systemd/systemd-udevd root 259 2 0 21:52 ? 00:00:00 [kworker/2:7-events_power_efficient] root 286 2 0 21:52 ? 00:00:00 [vchiq-keep/0] root 287 2 0 21:52 ? 00:00:00 [SMIO] root 326 2 0 21:52 ? 00:00:00 [mmal-vchiq] root 336 2 0 21:52 ? 00:00:00 [mmal-vchiq] root 343 2 0 21:52 ? 00:00:00 [irq/54-feb10000.codec] root 347 2 0 21:52 ? 00:00:00 [mmal-vchiq] root 349 2 0 21:52 ? 00:00:00 [mmal-vchiq] root 350 2 0 21:52 ? 00:00:00 [mmal-vchiq] root 352 2 0 21:52 ? 00:00:00 [mmal-vchiq] root 356 2 0 21:52 ? 00:00:00 [mmal-vchiq] root 365 2 0 21:52 ? 00:00:00 [kworker/u8:4-loop0] root 373 2 0 21:52 ? 00:00:00 [cfg80211] root 375 2 0 21:52 ? 00:00:00 [kworker/u9:1-hci0] root 376 2 0 21:52 ? 00:00:00 [kworker/u9:2-brcmf_wq/mmc1:0001:1] root 381 2 0 21:52 ? 00:00:00 [brcmf_wq/mmc1:0] root 382 2 0 21:52 ? 00:00:00 [brcmf_wdog/mmc1:0001:1] root 383 2 0 21:52 ? 00:00:00 [kworker/1:3-events_freezable] _rpc 444 1 0 21:52 ? 00:00:00 /sbin/rpcbind -f -w root 456 2 0 21:52 ? 00:00:00 [kworker/3:3-events] root 457 2 0 21:52 ? 00:00:00 [kworker/3:4-cgroup_destroy] root 458 2 0 21:52 ? 00:00:00 [kworker/3:5-events_power_efficient] root 459 2 0 21:52 ? 00:00:00 [kworker/3:6] root 466 1 1 21:52 ? 00:00:01 /usr/sbin/haveged --Foreground --verbose=1 -w 1024 root 508 1 0 21:52 ? 00:00:00 /lib/systemd/systemd-logind avahi 510 1 0 21:52 ? 00:00:00 avahi-daemon: running [sibermusic.local] message+ 511 1 0 21:52 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only root 519 1 0 21:52 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant volumio 520 1 0 21:52 ? 00:00:00 /usr/local/bin/volumio-remote-updater root 521 1 0 21:52 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon root 530 1 0 21:52 ? 00:00:00 /bin/bash /bin/volumiologrotate nobody 536 1 0 21:52 ? 00:00:00 /usr/sbin/thd --triggers /etc/triggerhappy/triggers.d/ --socket /run/thd.socket --user nobody --deviceglob /dev/input/event* avahi 541 510 0 21:52 ? 00:00:00 avahi-daemon: chroot helper root 558 2 0 21:52 ? 00:00:00 [kworker/0:3-events] shairpo+ 610 1 0 21:52 ? 00:00:00 /usr/bin/shairport-sync --configfile=/tmp/shairport-sync.conf root 624 1 0 21:52 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 626 2 0 21:52 ? 00:00:00 [kworker/1:4-events_freezable] root 628 2 0 21:52 ? 00:00:00 [kworker/1:5] root 657 1 0 21:52 ? 00:00:00 /usr/sbin/sshd -D root 663 1 0 21:52 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap root 670 1 0 21:52 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I ntp 674 1 0 21:52 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 root 699 624 0 21:52 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 786 1 0 21:52 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0 root 798 1 0 21:52 ? 00:00:00 /sbin/dhcpcd volumio 876 1 13 21:52 ? 00:00:21 /usr/bin/node /volumio/index.js root 906 1 0 21:52 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group root 910 906 0 21:52 ? 00:00:00 winbindd: domain child [SIBERMUSIC] root 911 1 0 21:52 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 913 911 0 21:52 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 914 911 0 21:52 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 915 906 0 21:52 ? 00:00:00 winbindd: idmap child root 916 906 0 21:52 ? 00:00:00 winbindd: domain child [BUILTIN] root 920 911 0 21:52 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 940 2 0 21:52 ? 00:00:00 [cifsiod] root 941 2 0 21:52 ? 00:00:00 [smb3decryptd] root 942 2 0 21:52 ? 00:00:00 [cifsfileinfoput] root 943 2 0 21:52 ? 00:00:00 [cifsoplockd] root 944 2 0 21:52 ? 00:00:00 [deferredclose] root 946 2 0 21:52 ? 00:00:00 [cifsd] volumio 1043 876 0 21:52 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1079 1043 0 21:52 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1080 1043 0 21:52 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1081 1043 0 21:52 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1146 1 0 21:52 ? 00:00:00 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf root 1377 2 0 21:53 ? 00:00:00 [rc0] volumio 1392 1 0 21:53 ? 00:00:00 /bin/sh /usr/bin/startx /etc/X11/Xsession /opt/volumiokiosk.sh -- -nocursor volumio 1393 1 0 21:53 ? 00:00:00 /bin/sh /bin/start-go-liberspot.sh volumio 1396 1393 0 21:53 ? 00:00:00 /usr/bin/go-librespot -config_path /tmp/go-librespot-config.yml -credentials_path /data/configuration/music_service/spop/spotifycredentials.json volumio 1440 1392 0 21:53 ? 00:00:00 xinit /etc/X11/Xsession /opt/volumiokiosk.sh -- /usr/bin/X :0 -nocursor -auth /tmp/serverauth.Yk4pAgC0PL root 1441 1440 0 21:53 tty2 00:00:01 /usr/lib/xorg/Xorg :0 -nocursor -auth /tmp/serverauth.Yk4pAgC0PL root 1533 1 0 21:53 ? 00:00:00 /usr/sbin/lircd --nodaemon root 1592 1533 0 21:53 ? 00:00:00 [sh] root 1624 1 0 21:53 ? 00:00:00 /usr/bin/irexec /etc/lirc/irexec.lircrc volumio 1662 1440 0 21:53 ? 00:00:00 /bin/bash /opt/volumiokiosk.sh volumio 1688 1662 0 21:53 ? 00:00:00 /usr/bin/ssh-agent /opt/volumiokiosk.sh volumio 1695 1662 0 21:53 ? 00:00:00 /usr/bin/openbox --startup /usr/lib/arm-linux-gnueabihf/openbox-autostart OPENBOX volumio 1696 1662 2 21:53 ? 00:00:02 /usr/lib/chromium-browser/chromium-browser-v7 --enable-pinch --simulate-outdated-no-au=Tue, 31 Dec 2099 23:59:59 GMT --force-device-scale-factor=0.89 --disable-pinch --kiosk --no-first-run --noerrdialogs --disable-3d-apis --disable-breakpad --disable-crash-reporter --disable-infobars --disable-session-crashed-bubble --disable-translate --user-data-dir=/data/volumiokiosk http://localhost:4004 volumio 1745 1 0 21:53 ? 00:00:00 /usr/lib/chromium-browser/crashpad_handler --monitor-self --monitor-self-annotation=ptype=crashpad-handler --database=/home/volumio/.config/chromium/Crash Reports --metrics-dir=/data/volumiokiosk --annotation=channel=Built on Raspbian , running on Raspbian 10 --annotation=lsb-release=Raspbian GNU/Linux 10 (buster) --annotation=plat=Linux --annotation=prod=Chrome_Linux --annotation=ver=92.0.4515.98 --initial-client-fd=7 --shared-client-connection volumio 1747 1 0 21:53 ? 00:00:00 /usr/lib/chromium-browser/crashpad_handler --no-periodic-tasks --monitor-self-annotation=ptype=crashpad-handler --database=/home/volumio/.config/chromium/Crash Reports --annotation=channel=Built on Raspbian , running on Raspbian 10 --annotation=lsb-release=Raspbian GNU/Linux 10 (buster) --annotation=plat=Linux --annotation=prod=Chrome_Linux --annotation=ver=92.0.4515.98 --initial-client-fd=4 --shared-client-connection volumio 1751 1696 0 21:53 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --no-zygote-sandbox --force-device-scale-factor=0.89 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad volumio 1752 1696 0 21:53 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --force-device-scale-factor=0.89 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad volumio 1754 1752 0 21:53 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --force-device-scale-factor=0.89 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad volumio 1764 876 0 21:53 ? 00:00:00 /usr/bin/node /myvolumio/plugins/music_service/streaming_services/streamingProxy.js volumio 1798 1696 0 21:53 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=utility --utility-sub-type=network.mojom.NetworkService --field-trial-handle=13658777801350483923,8476220057234329239,131072 --lang=en-US --service-sandbox-type=none --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --shared-files=v8_context_snapshot_data:100 --enable-crashpad volumio 1813 1751 0 21:53 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=gpu-process --field-trial-handle=13658777801350483923,8476220057234329239,131072 --disable-breakpad --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --gpu-preferences=UAAAAAAAAAAgAAAQAAAAAAAAAAAAAAAAAABgAAAAAAAwAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAQAAANgAAAAAAAAA2AAAAAAAAABIAAAACAAAAEAAAAAAAAAASAAAAAAAAABQAAAAAAAAAFgAAAAAAAAAYAAAAAAAAABoAAAAAAAAAHAAAAAAAAAAeAAAAAAAAAAQAAAAAAAAAAAAAAAMAAAAEAAAAAAAAAAAAAAADQAAABAAAAAAAAAAAQAAAAwAAAAQAAAAAAAAAAEAAAANAAAAEAAAAAAAAAAEAAAADAAAABAAAAAAAAAABAAAAA0AAAAQAAAAAAAAAAcAAAAMAAAAEAAAAAAAAAAHAAAADQAAAAgAAAAAAAAACAAAAAAAAAA= --use-gl=swiftshader-webgl --shared-files volumio 1818 1754 0 21:53 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=utility --utility-sub-type=storage.mojom.StorageService --field-trial-handle=13658777801350483923,8476220057234329239,131072 --lang=en-US --service-sandbox-type=utility --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --shared-files=v8_context_snapshot_data:100 volumio 1829 1813 0 21:53 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=broker volumio 1873 1754 0 21:53 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=renderer --disable-breakpad --force-device-scale-factor=0.89 --field-trial-handle=13658777801350483923,8476220057234329239,131072 --disable-gpu-compositing --lang=en-US --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --disable-3d-apis --num-raster-threads=1 --renderer-client-id=7 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100 volumio 1875 1754 5 21:53 ? 00:00:04 /usr/lib/chromium-browser/chromium-browser-v7 --type=renderer --disable-breakpad --force-device-scale-factor=0.89 --field-trial-handle=13658777801350483923,8476220057234329239,131072 --disable-gpu-compositing --lang=en-US --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --disable-3d-apis --num-raster-threads=1 --renderer-client-id=6 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100 mpd 1973 1 0 21:53 ? 00:00:00 /usr/bin/mpd --systemd volumio 1985 1 0 21:53 ? 00:00:00 /bin/sh /tmp/sshtunnel.sh volumio 1988 1985 0 21:53 ? 00:00:00 /usr/lib/autossh/autossh -M 0 -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R h0PZQsB39AURSlylidLe37OavVF3-88dd99399252828aa992fa9b2610eee3.eu2.myvolumio.org:8091:localhost:3000 eu2.myvolumio.org volumio 1991 1988 0 21:53 ? 00:00:00 /usr/bin/ssh -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R h0PZQsB39AURSlylidLe37OavVF3-88dd99399252828aa992fa9b2610eee3.eu2.myvolumio.org:8091:localhost:3000 eu2.myvolumio.org volumio 2023 1 0 21:53 ? 00:00:00 /bin/sh /bin/bt/btstart.sh start volumio 2031 1 0 21:53 ? 00:00:00 /usr/bin/pulseaudio --high-priority=true rtkit 2032 1 0 21:53 ? 00:00:00 /usr/lib/rtkit/rtkit-daemon root 2035 1 0 21:53 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug root 2043 2 0 21:53 ? 00:00:00 [krfcommd] volumio 2045 2023 0 21:53 ? 00:00:00 /usr/bin/python /bin/bt/simple-agent -c NoInputNoOutput root 2269 530 0 21:54 ? 00:00:00 [sleep] volumio 2272 876 0 21:55 ? 00:00:00 /bin/sh -c /usr/bin/node /volumio/logsubmit.js 'Weather info not loading on Now Playing idle screen' volumio 2273 2272 0 21:55 ? 00:00:00 /usr/bin/node /volumio/logsubmit.js Weather info not loading on Now Playing idle screen volumio 2301 2273 0 21:55 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 2302 2301 0 21:55 ? 00:00:00 ps -ef # df -h --------------- Filesystem Size Used Avail Use% Mounted on /dev/mmcblk0p2 2.5G 1.1G 1.2G 48% /imgpart /dev/loop0 473M 473M 0 100% /static overlay 4.7G 3.0G 1.5G 67% / devtmpfs 1.9G 0 1.9G 0% /dev tmpfs 1.9G 59M 1.8G 4% /dev/shm tmpfs 1.9G 5.3M 1.9G 1% /run tmpfs 5.0M 4.0K 5.0M 1% /run/lock tmpfs 1.9G 0 1.9G 0% /sys/fs/cgroup tmpfs 1.9G 4.1M 1.9G 1% /tmp tmpfs 20M 52K 20M 1% /var/log tmpfs 1.9G 0 1.9G 0% /var/spool/cups tmpfs 1.9G 0 1.9G 0% /var/spool/cups/tmp /dev/mmcblk0p1 92M 66M 27M 72% /boot //192.168.178.185/USB 4.6G 1.4G 3.3G 30% /mnt/NAS/USB # mount --------------- /dev/mmcblk0p2 on /imgpart type ext4 (rw,relatime) /dev/loop0 on /static type squashfs (ro,relatime,errors=continue) overlay on / type overlay (rw,relatime,lowerdir=/mnt/static,upperdir=/mnt/ext/dyn,workdir=/mnt/ext/work) sysfs on /sys type sysfs (rw,nosuid,nodev,noexec,relatime) proc on /proc type proc (rw,relatime) devtmpfs on /dev type devtmpfs (rw,nosuid,size=1898692k,nr_inodes=146530,mode=755) securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime) tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev,noexec) devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000) tmpfs on /run type tmpfs (rw,nosuid,nodev,mode=755) tmpfs on /run/lock type tmpfs (rw,nosuid,nodev,noexec,relatime,size=5120k) tmpfs on /sys/fs/cgroup type tmpfs (ro,nosuid,nodev,noexec,mode=755) cgroup2 on /sys/fs/cgroup/unified type cgroup2 (rw,nosuid,nodev,noexec,relatime,nsdelegate) cgroup on /sys/fs/cgroup/systemd type cgroup (rw,nosuid,nodev,noexec,relatime,xattr,name=systemd) pstore on /sys/fs/pstore type pstore (rw,nosuid,nodev,noexec,relatime) bpf on /sys/fs/bpf type bpf (rw,nosuid,nodev,noexec,relatime,mode=700) cgroup on /sys/fs/cgroup/pids type cgroup (rw,nosuid,nodev,noexec,relatime,pids) cgroup on /sys/fs/cgroup/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset) cgroup on /sys/fs/cgroup/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpu,cpuacct) cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer) cgroup on /sys/fs/cgroup/perf_event type cgroup (rw,nosuid,nodev,noexec,relatime,perf_event) cgroup on /sys/fs/cgroup/blkio type cgroup (rw,nosuid,nodev,noexec,relatime,blkio) cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices) cgroup on /sys/fs/cgroup/net_cls,net_prio type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls,net_prio) systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=32,pgrp=1,timeout=0,minproto=5,maxproto=5,direct) debugfs on /sys/kernel/debug type debugfs (rw,relatime) sunrpc on /run/rpc_pipefs type rpc_pipefs (rw,relatime) mqueue on /dev/mqueue type mqueue (rw,relatime) configfs on /sys/kernel/config type configfs (rw,relatime) tmpfs on /tmp type tmpfs (rw,noatime,mode=755) tmpfs on /var/log type tmpfs (rw,nodev,relatime,size=20480k,mode=777,uid=1000,gid=4) tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755) tmpfs on /var/spool/cups/tmp type tmpfs (rw,noatime,mode=755) /dev/mmcblk0p1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=ascii,shortname=mixed,utf8,errors=remount-ro,user) none on /cpusets type cgroup (rw,relatime,cpuset) //192.168.178.185/USB on /mnt/NAS/USB type cifs (ro,relatime,vers=3.1.1,sec=none,cache=strict,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.178.185,file_mode=0666,dir_mode=0777,iocharset=utf8,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=1048576,echo_interval=60,actimeo=1,closetimeo=1) # netstat -natp --------------- (Not all processes could be identified, non-owned process info will not be shown, you would have to be root to see it all.) Active Internet connections (servers and established) Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name tcp 0 0 0.0.0.0:49149 0.0.0.0:* LISTEN 1146/upmpdcli tcp 0 0 0.0.0.0:445 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:5000 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:139 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:4713 0.0.0.0:* LISTEN 2031/pulseaudio tcp 0 0 0.0.0.0:111 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:22 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:49152 0.0.0.0:* LISTEN 1146/upmpdcli tcp 0 0 192.168.178.227:54104 35.186.224.25:443 TIME_WAIT - tcp 0 0 192.168.178.227:50290 142.251.36.36:443 CLOSE_WAIT 1798/volumiokiosk - tcp 0 0 192.168.178.227:53324 35.186.224.34:443 ESTABLISHED 1396/go-librespot tcp 0 0 127.0.0.1:51314 127.0.0.1:3000 ESTABLISHED 876/node tcp 0 0 127.0.0.1:48032 127.0.0.1:3000 TIME_WAIT - tcp 0 0 127.0.0.1:58060 127.0.0.1:3000 ESTABLISHED 876/node tcp 0 0 127.0.0.1:48402 127.0.0.1:3000 ESTABLISHED 876/node tcp 0 0 127.0.0.1:54762 127.0.0.1:3000 ESTABLISHED 876/node tcp 0 0 192.168.178.227:33742 192.168.178.108:8009 ESTABLISHED 1798/volumiokiosk - tcp 0 0 192.168.178.227:35140 35.201.97.85:443 ESTABLISHED 876/node tcp 0 0 192.168.178.227:35280 192.168.178.185:445 ESTABLISHED - tcp 0 0 127.0.0.1:54788 127.0.0.1:3000 ESTABLISHED 520/volumio-remote- tcp 0 0 127.0.0.1:38860 127.0.0.1:9879 ESTABLISHED 876/node tcp 0 0 192.168.178.227:47460 185.14.187.123:2222 ESTABLISHED 1991/ssh tcp 0 0 192.168.178.227:58346 84.247.14.230:80 ESTABLISHED 876/node tcp 0 0 192.168.178.227:54120 35.186.224.25:443 TIME_WAIT - tcp 0 0 127.0.0.1:57718 127.0.0.1:6599 ESTABLISHED 1146/upmpdcli tcp 0 0 192.168.178.227:35702 142.250.27.84:443 ESTABLISHED 1798/volumiokiosk - tcp 0 0 192.168.178.227:54134 35.186.224.25:443 TIME_WAIT - tcp 0 0 192.168.178.227:35334 192.168.178.185:3000 ESTABLISHED 876/node tcp 0 0 192.168.178.227:42436 142.250.179.131:443 ESTABLISHED 1798/volumiokiosk - tcp 0 0 192.168.178.227:34208 34.158.0.131:4070 ESTABLISHED 1396/go-librespot tcp 0 0 192.168.178.227:39360 35.186.224.17:443 ESTABLISHED 1396/go-librespot tcp 0 0 127.0.0.1:57702 127.0.0.1:6599 ESTABLISHED 1146/upmpdcli tcp 0 0 127.0.0.1:43852 127.0.0.1:3000 ESTABLISHED 876/node tcp 0 0 127.0.0.1:48392 127.0.0.1:3000 ESTABLISHED 1798/volumiokiosk - tcp 0 0 192.168.178.227:41440 142.251.39.99:443 ESTABLISHED 1798/volumiokiosk - tcp 0 0 192.168.178.227:50276 142.251.36.36:443 CLOSE_WAIT 1798/volumiokiosk - tcp6 0 0 :::6599 :::* LISTEN 876/node tcp6 0 0 :::6600 :::* LISTEN - tcp6 0 0 :::3000 :::* LISTEN 876/node tcp6 0 0 :::3001 :::* LISTEN 1043/node tcp6 0 0 :::3005 :::* LISTEN 876/node tcp6 0 0 :::445 :::* LISTEN - tcp6 0 0 :::4004 :::* LISTEN 876/node tcp6 0 0 :::5000 :::* LISTEN - tcp6 0 0 :::3245 :::* LISTEN 1764/node tcp6 0 0 :::9879 :::* LISTEN 1396/go-librespot tcp6 0 0 :::139 :::* LISTEN - tcp6 0 0 :::4713 :::* LISTEN 2031/pulseaudio tcp6 0 0 :::111 :::* LISTEN - tcp6 0 0 :::22 :::* LISTEN - tcp6 0 0 127.0.0.1:3000 127.0.0.1:48402 ESTABLISHED 876/node tcp6 0 0 192.168.178.227:3000 192.168.178.129:43104 ESTABLISHED 876/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:58060 ESTABLISHED 876/node tcp6 0 0 127.0.0.1:4004 127.0.0.1:43314 TIME_WAIT - tcp6 0 0 127.0.0.1:6599 127.0.0.1:57718 ESTABLISHED 876/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:48392 ESTABLISHED 876/node tcp6 0 0 192.168.178.227:4004 192.168.178.227:52802 TIME_WAIT - tcp6 0 0 127.0.0.1:3000 127.0.0.1:54762 ESTABLISHED 876/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:43852 ESTABLISHED 876/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:54788 ESTABLISHED 876/node tcp6 0 0 127.0.0.1:6599 127.0.0.1:57702 ESTABLISHED 876/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:48434 TIME_WAIT - tcp6 0 0 127.0.0.1:4004 127.0.0.1:43422 TIME_WAIT - tcp6 0 0 192.168.178.227:3000 192.168.178.185:60946 ESTABLISHED 876/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:51314 ESTABLISHED 876/node tcp6 0 0 127.0.0.1:9879 127.0.0.1:38860 ESTABLISHED 1396/go-librespot # cat /etc/asound.conf --------------- pcm.!default { type empty slave.pcm "volumio" } pcm.volumio { type empty slave.pcm "volumioMultiRoomServer" } # This PCM switches output to the ALSA target named by the file /tmp/multiroom/server/switch.target pcm.volumioMultiRoomServer { type volumioswitch target_file "/tmp/multiroom/server/switch.target" control_fifo "/tmp/multiroom/server/switch.fifo" format_append "true" format_1 "DSD_U32_BE" rate_min 44100 rate_max 384000 } # This PCM switches output to the ALSA target named by the file /tmp/multiroom/client/switch.target pcm.volumioMultiRoomClient { type volumioswitch target_file "/tmp/multiroom/client/switch.target" control_fifo "/tmp/multiroom/client/switch.fifo" } # This PCM performs any necessary rate/format/channel conversion before sending on to the Server FIFO pcm.volumioMultiRoom { type plug slave { pcm "volumioMultiRoomFIFO" rate 48000 format "S16_LE" channels 2 } rate_converter "speexrate_medium" } # Write to the FIFO watched by the Server pcm.volumioMultiRoomFIFO { type volumiofifo fifo "/tmp/multiroom/server/fifo" clear_on_drop false lead_in_frames 16384 } # This pcm is used by pcm.volumioMultiRoomServer and pcm.volumioMultiRoomClient to play audio on the local output pcm.volumioLocalPlayback { type empty slave.pcm "postMultiRoom" } # This pcm is used by pcm.volumioMultiRoomClient to discard audio and allow for faster switching pcm.volumioDiscard { type null } pcm.postMultiRoom { type empty slave.pcm "volumioOutput" } # There is always a plug before the hardware to be safe pcm.volumioOutput { type plug slave.pcm "volumioHw" } pcm.volumioHw { type hw card "D10s" } # cat /var/log/mpd.log --------------- Apr 07 21:53 : zeroconf: No global port, disabling zeroconf Apr 07 21:53 : exception: No such directory Apr 07 21:53 : zeroconf: No global port, disabling zeroconf # cat /tmp/camilladsp.log --------------- cat: /tmp/camilladsp.log: No such file or directory # cat /tmp/cec-client.log --------------- cat: /tmp/cec-client.log: No such file or directory # volumio plugin list --------------- This command will list installed plugins on your device ----------------------- Installed Plugins: [ { prettyName: 'Bandcamp Discover', name: 'bandcamp', category: 'music_service', version: '1.1.1', icon: 'fa-bandcamp', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Spotify', name: 'spop', category: 'music_service', version: '4.0.4', icon: 'fa-spotify', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'YouTube Music', name: 'ytmusic', category: 'music_service', version: '1.0.2', icon: 'fa-youtube-play', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'IR Remote Controller', name: 'ir_controller', category: 'system_hardware', version: '3.4.12', icon: 'fa-magic', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Music Services Shield', name: 'music_services_shield', category: 'system_hardware', version: '1.3.1', icon: 'fa-shield', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Now Playing', name: 'now_playing', category: 'user_interface', version: '0.5.5', icon: 'fa-play-circle', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Touch Display', name: 'touch_display', category: 'user_interface', version: '3.4.0', icon: 'fa-hand-pointer-o', isManuallyInstalled: false, enabled: true, active: true } ] ------------------------------------------ # cat /data/configuration/plugins.json --------------- { "music_service": { "airplay_emulation": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STOPPED" } }, "inputs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "mpd": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "webradio": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "example_plugin": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STOPPED" } }, "last_100": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "upnp_browser": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "streaming_services": { "status": { "type": "string", "value": "STARTED" } }, "cd_controller": { "status": { "type": "string", "value": "STOPPED" }, "enabled": { "type": "boolean", "value": false } }, "smart_inputs": { "status": { "type": "string", "value": "STARTED" } }, "hi_res_audio": { "status": { "type": "string", "value": "STARTED" } }, "tidal": { "status": { "type": "string", "value": "STARTED" } }, "qobuz": { "status": { "type": "string", "value": "STARTED" } }, "tidalconnect": { "status": { "type": "string", "value": "STOPPED" }, "enabled": { "type": "boolean", "value": false } }, "bandcamp": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "spop": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "ytmusic": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } } }, "audio_interface": { "outputs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "upnp": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "alsa_controller": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "bluetooth": { "status": { "type": "string", "value": "STARTED" }, "enabled": { "type": "boolean", "value": true } }, "multiroom": { "status": { "type": "string", "value": "STARTED" } } }, "miscellanea": { "alarm-clock": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "albumart": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "appearance": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "wizard": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "my_music": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "metavolumio": { "status": { "type": "string", "value": "STARTED" } }, "manifestui": { "status": { "type": "string", "value": "STARTED" } } }, "user_interface": { "websocket": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "mpdemulation": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STARTED" } }, "rest_api": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "touch_display": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "now_playing": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } } }, "system_controller": { "updater_comm": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "network": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "networkfs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "services": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "system": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "i2s_dacs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "volumiodiscovery": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "volumio_command_line_client": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "my_volumio": { "status": { "type": "string", "value": "STARTED" } } }, "system_hardware": { "ir_controller": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "music_services_shield": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } } } } # cat /etc/mpd.conf --------------- # Volumio MPD Configuration File # Files and directories ####################################################### music_directory "/var/lib/mpd/music" playlist_directory "/var/lib/mpd/playlists" db_file "/var/lib/mpd/tag_cache" log_file "/var/log/mpd.log" #pid_file "/var/run/mpd/pid" #state_file "/var/lib/mpd/state" #sticker_file "/var/lib/mpd/sticker.sql" ############################################################################### # General music daemon options ################################################ user "mpd" group "audio" bind_to_address "any" #port "6600" log_level "default" #save_absolute_paths_in_playlists "no" #metadata_to_use "artist,album,title,track,name,genre,date,composer,performer,disc" auto_update "no" #auto_update_depth "3" ############################################################################### # Symbolic link behavior ###################################################### follow_outside_symlinks "yes" follow_inside_symlinks "yes" ############################################################################### # Input ####################################################################### # input { plugin "curl" # proxy "proxy.isp.com:8080" # proxy_user "user" # proxy_password "password" } ############################################################################### # Decoder ################################################################ decoder { plugin "faad" enabled "no" } ############################################################################### # Audio Output ################################################################ resampler { plugin "soxr" quality "high" threads "1" } audio_output { type "alsa" name "alsa" device "volumio" dop "no" } audio_output { type "fifo" enabled "no" name "multiroom" path "/tmp/snapfifo" format "44100:16:2" } #replaygain "album" #replaygain_preamp "0" volume_normalization "no" ############################################################################### # MPD Internal Buffering ###################################################### audio_buffer_size "2048" ############################################################################### # Resource Limitations ######################################################## #connection_timeout "60" max_connections "20" max_playlist_length "81920" max_command_list_size "81920" max_output_buffer_size "81920" ############################################################################### # Character Encoding ########################################################## filesystem_charset "UTF-8" ############################################################################### # volumio endpointstest --------------- TESTING REMOTE ENDPOINTS https://google.com, 5337 ms: OK https://www.googleapis.com, 427 ms: OK https://securetoken.googleapis.com, 413 ms: OK https://myvolumio.firebaseio.com, 530 ms: OK https://functions.volumio.cloud, 651 ms: OK https://oauth-performer.dfs.volumio.org, 1236 ms: OK https://browsing-performer.dfs.volumio.org, 1422 ms: OK http://cddb.volumio.org, 5075 ms: FAILED https://functions.volumio.cloud, 5076 ms: FAILED http://pushupdates.volumio.org, 5076 ms: FAILED http://plugins.volumio.org, 5077 ms: FAILED https://database.volumio.cloud, 5078 ms: FAILED https://radio-directory.firebaseapp.com, 5080 ms: FAILED ---------- WARNING!!! Some remote endpoints cannot be reached! Failing endpoints: http://cddb.volumio.org, 5080 ms https://functions.volumio.cloud, 5080 ms http://pushupdates.volumio.org, 5080 ms http://plugins.volumio.org, 5080 ms https://database.volumio.cloud, 5080 ms https://radio-directory.firebaseapp.com, 5080 ms ---------- # cat /data/updatesHistoryFile --------------- --- Fri Oct 20 2023 13:46:04 GMT+0000 (Coordinated Universal Time) {"systemversion":"3.569","builddate":"Fri 20 Oct 2023 03:38:28 PM CEST","variant":"volumio","hardware":"pi"} ------ Sun Jan 28 2024 22:52:35 GMT+0100 (Central European Standard Time) {"systemversion":"3.601","builddate":"Fri 19 Jan 2024 06:17:59 PM CET","variant":"volumio","hardware":"pi"} ------ Thu Feb 01 2024 07:27:28 GMT+0100 (Central European Standard Time) {"systemversion":"3.611","builddate":"Tue 30 Jan 2024 03:58:37 PM CET","variant":"volumio","hardware":"pi"} ------ Wed Feb 14 2024 16:09:46 GMT+0100 (Central European Standard Time) {"systemversion":"3.616","builddate":"Tue 13 Feb 2024 06:28:23 PM CET","variant":"volumio","hardware":"pi"} ------ Wed Feb 28 2024 19:27:57 GMT+0100 (Central European Standard Time) {"systemversion":"3.631","builddate":"Wed 21 Feb 2024 09:37:22 PM CET","variant":"volumio","hardware":"pi"} --- # sudo journalctl -p 7 --------------- -- Logs begin at Wed 2024-04-03 13:47:49 CEST, end at Sun 2024-04-07 21:55:17 CEST. -- Apr 03 13:47:49 sibermusic kernel: Booting Linux on physical CPU 0x0 Apr 03 13:47:49 sibermusic kernel: Linux version 6.1.69-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1710 SMP Thu Dec 21 13:17:38 GMT 2023 Apr 03 13:47:49 sibermusic kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d Apr 03 13:47:49 sibermusic kernel: CPU: div instructions available: patching division code Apr 03 13:47:49 sibermusic kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache Apr 03 13:47:49 sibermusic kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.2 Apr 03 13:47:49 sibermusic kernel: random: crng init done Apr 03 13:47:49 sibermusic kernel: Memory policy: Data cache writealloc Apr 03 13:47:49 sibermusic kernel: Reserved memory: created CMA memory pool at 0x000000002a000000, size 64 MiB Apr 03 13:47:49 sibermusic kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Apr 03 13:47:49 sibermusic kernel: Zone ranges: Apr 03 13:47:49 sibermusic kernel: DMA [mem 0x0000000000000000-0x000000002fffffff] Apr 03 13:47:49 sibermusic kernel: Normal empty Apr 03 13:47:49 sibermusic kernel: HighMem [mem 0x0000000030000000-0x00000000fbffffff] Apr 03 13:47:49 sibermusic kernel: Movable zone start for each node Apr 03 13:47:49 sibermusic kernel: Early memory node ranges Apr 03 13:47:49 sibermusic kernel: node 0: [mem 0x0000000000000000-0x0000000037ffffff] Apr 03 13:47:49 sibermusic kernel: node 0: [mem 0x0000000040000000-0x00000000fbffffff] Apr 03 13:47:49 sibermusic kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff] Apr 03 13:47:49 sibermusic kernel: percpu: Embedded 17 pages/cpu s37012 r8192 d24428 u69632 Apr 03 13:47:49 sibermusic kernel: pcpu-alloc: s37012 r8192 d24428 u69632 alloc=17*4096 Apr 03 13:47:49 sibermusic kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Apr 03 13:47:49 sibermusic kernel: Built 1 zonelists, mobility grouping on. Total pages: 997696 Apr 03 13:47:49 sibermusic kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:6C:7A:FC vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 Apr 03 13:47:49 sibermusic kernel: Kernel parameter elevator= does not have any effect anymore. Please use sysfs to set IO scheduler for individual devices. Apr 03 13:47:49 sibermusic kernel: Unknown kernel command line parameters "splash imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh bootdelay=5", will be passed to user space. Apr 03 13:47:49 sibermusic kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) Apr 03 13:47:49 sibermusic kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 03 13:47:49 sibermusic kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 03 13:47:49 sibermusic kernel: software IO TLB: area num 4. Apr 03 13:47:49 sibermusic kernel: software IO TLB: mapped [mem 0x0000000023c90000-0x0000000027c90000] (64MB) Apr 03 13:47:49 sibermusic kernel: Memory: 3797384K/3997696K available (10240K kernel code, 1505K rwdata, 3388K rodata, 2048K init, 637K bss, 134776K reserved, 65536K cma-reserved, 3211264K highmem) Apr 03 13:47:49 sibermusic kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Apr 03 13:47:49 sibermusic kernel: ftrace: allocating 37226 entries in 110 pages Apr 03 13:47:49 sibermusic kernel: ftrace: allocated 110 pages with 5 groups Apr 03 13:47:49 sibermusic kernel: trace event string verifier disabled Apr 03 13:47:49 sibermusic kernel: rcu: Hierarchical RCU implementation. Apr 03 13:47:49 sibermusic kernel: Rude variant of Tasks RCU enabled. Apr 03 13:47:49 sibermusic kernel: Tracing variant of Tasks RCU enabled. Apr 03 13:47:49 sibermusic kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. Apr 03 13:47:49 sibermusic kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Apr 03 13:47:49 sibermusic kernel: GIC: Using split EOI/Deactivate mode Apr 03 13:47:49 sibermusic kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 03 13:47:49 sibermusic kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Apr 03 13:47:49 sibermusic kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Apr 03 13:47:49 sibermusic kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Apr 03 13:47:49 sibermusic kernel: Switching to timer-based delay loop, resolution 18ns Apr 03 13:47:49 sibermusic kernel: Console: colour dummy device 80x30 Apr 03 13:47:49 sibermusic kernel: printk: console [tty1] enabled Apr 03 13:47:49 sibermusic kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000) Apr 03 13:47:49 sibermusic kernel: CPU: Testing write buffer coherency: ok Apr 03 13:47:49 sibermusic kernel: CPU0: Spectre BHB: enabling loop workaround for all CPUs Apr 03 13:47:49 sibermusic kernel: pid_max: default: 32768 minimum: 301 Apr 03 13:47:49 sibermusic kernel: LSM: Security Framework initializing Apr 03 13:47:49 sibermusic kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Apr 03 13:47:49 sibermusic kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Apr 03 13:47:49 sibermusic kernel: cgroup: Disabling memory control group subsystem Apr 03 13:47:49 sibermusic kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Apr 03 13:47:49 sibermusic kernel: cblist_init_generic: Setting adjustable number of callback queues. Apr 03 13:47:49 sibermusic kernel: cblist_init_generic: Setting shift to 2 and lim to 1. Apr 03 13:47:49 sibermusic kernel: cblist_init_generic: Setting adjustable number of callback queues. Apr 03 13:47:49 sibermusic kernel: cblist_init_generic: Setting shift to 2 and lim to 1. Apr 03 13:47:49 sibermusic kernel: Setting up static identity map for 0x200000 - 0x20003c Apr 03 13:47:49 sibermusic kernel: rcu: Hierarchical SRCU implementation. Apr 03 13:47:49 sibermusic kernel: rcu: Max phase no-delay instances is 1000. Apr 03 13:47:49 sibermusic kernel: smp: Bringing up secondary CPUs ... Apr 03 13:47:49 sibermusic kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Apr 03 13:47:49 sibermusic kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Apr 03 13:47:49 sibermusic kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Apr 03 13:47:49 sibermusic kernel: smp: Brought up 1 node, 4 CPUs Apr 03 13:47:49 sibermusic kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS). Apr 03 13:47:49 sibermusic kernel: CPU: All CPU(s) started in HYP mode. Apr 03 13:47:49 sibermusic kernel: CPU: Virtualization extensions available. Apr 03 13:47:49 sibermusic kernel: devtmpfs: initialized Apr 03 13:47:49 sibermusic kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0 Apr 03 13:47:49 sibermusic kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Apr 03 13:47:49 sibermusic kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Apr 03 13:47:49 sibermusic kernel: pinctrl core: initialized pinctrl subsystem Apr 03 13:47:49 sibermusic kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 03 13:47:49 sibermusic kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Apr 03 13:47:49 sibermusic kernel: audit: initializing netlink subsys (disabled) Apr 03 13:47:49 sibermusic kernel: audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 Apr 03 13:47:49 sibermusic kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 03 13:47:49 sibermusic kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Apr 03 13:47:49 sibermusic kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Apr 03 13:47:49 sibermusic kernel: Serial: AMBA PL011 UART driver Apr 03 13:47:49 sibermusic kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled Apr 03 13:47:49 sibermusic kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2023-10-17T15:39:16, variant start Apr 03 13:47:49 sibermusic kernel: raspberrypi-firmware soc:firmware: Firmware hash is 30f0c5e4d076da3ab4f341d88e7d505760b93ad7 Apr 03 13:47:49 sibermusic kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Apr 03 13:47:49 sibermusic kernel: bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1 Apr 03 13:47:49 sibermusic kernel: SCSI subsystem initialized Apr 03 13:47:49 sibermusic kernel: usbcore: registered new interface driver usbfs Apr 03 13:47:49 sibermusic kernel: usbcore: registered new interface driver hub Apr 03 13:47:49 sibermusic kernel: usbcore: registered new device driver usb Apr 03 13:47:49 sibermusic kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator Apr 03 13:47:49 sibermusic kernel: pps_core: LinuxPPS API ver. 1 registered Apr 03 13:47:49 sibermusic kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Apr 03 13:47:49 sibermusic kernel: PTP clock support registered Apr 03 13:47:49 sibermusic kernel: vgaarb: loaded Apr 03 13:47:49 sibermusic kernel: clocksource: Switched to clocksource arch_sys_counter Apr 03 13:47:49 sibermusic kernel: VFS: Disk quotas dquot_6.6.0 Apr 03 13:47:49 sibermusic kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Apr 03 13:47:49 sibermusic kernel: FS-Cache: Loaded Apr 03 13:47:49 sibermusic kernel: CacheFiles: Loaded Apr 03 13:47:49 sibermusic kernel: NET: Registered PF_INET protocol family Apr 03 13:47:49 sibermusic kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Apr 03 13:47:49 sibermusic kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear) Apr 03 13:47:49 sibermusic kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 03 13:47:49 sibermusic kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Apr 03 13:47:49 sibermusic kernel: TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) Apr 03 13:47:49 sibermusic kernel: TCP: Hash tables configured (established 8192 bind 8192) Apr 03 13:47:49 sibermusic kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Apr 03 13:47:49 sibermusic kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Apr 03 13:47:49 sibermusic kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 03 13:47:49 sibermusic kernel: RPC: Registered named UNIX socket transport module. Apr 03 13:47:49 sibermusic kernel: RPC: Registered udp transport module. Apr 03 13:47:49 sibermusic kernel: RPC: Registered tcp transport module. Apr 03 13:47:49 sibermusic kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Apr 03 13:47:49 sibermusic kernel: PCI: CLS 0 bytes, default 64 Apr 03 13:47:49 sibermusic kernel: Trying to unpack rootfs image as initramfs... Apr 03 13:47:49 sibermusic kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available Apr 03 13:47:49 sibermusic kernel: Initialise system trusted keyrings Apr 03 13:47:49 sibermusic kernel: workingset: timestamp_bits=14 max_order=20 bucket_order=6 Apr 03 13:47:49 sibermusic kernel: zbud: loaded Apr 03 13:47:49 sibermusic kernel: NFS: Registering the id_resolver key type Apr 03 13:47:49 sibermusic kernel: Key type id_resolver registered Apr 03 13:47:49 sibermusic kernel: Key type id_legacy registered Apr 03 13:47:49 sibermusic kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Apr 03 13:47:49 sibermusic kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Apr 03 13:47:49 sibermusic kernel: Key type asymmetric registered Apr 03 13:47:49 sibermusic kernel: Asymmetric key parser 'x509' registered Apr 03 13:47:49 sibermusic kernel: bounce: pool size: 64 pages Apr 03 13:47:49 sibermusic kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Apr 03 13:47:49 sibermusic kernel: io scheduler mq-deadline registered Apr 03 13:47:49 sibermusic kernel: io scheduler kyber registered Apr 03 13:47:49 sibermusic kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: Apr 03 13:47:49 sibermusic kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] Apr 03 13:47:49 sibermusic kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000 Apr 03 13:47:49 sibermusic kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000 Apr 03 13:47:49 sibermusic kernel: brcm-pcie fd500000.pcie: setting SCB_ACCESS_EN, READ_UR_MODE, MAX_BURST_SIZE Apr 03 13:47:49 sibermusic kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 Apr 03 13:47:49 sibermusic kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Apr 03 13:47:49 sibermusic kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff]) Apr 03 13:47:49 sibermusic kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 Apr 03 13:47:49 sibermusic kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Apr 03 13:47:49 sibermusic kernel: PCI: bus0: Fast back to back transfers disabled Apr 03 13:47:49 sibermusic kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Apr 03 13:47:49 sibermusic kernel: pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator Apr 03 13:47:49 sibermusic kernel: pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator Apr 03 13:47:49 sibermusic kernel: pci_bus 0000:01: supply vpcie12v not found, using dummy regulator Apr 03 13:47:49 sibermusic kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) Apr 03 13:47:49 sibermusic kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 Apr 03 13:47:49 sibermusic kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Apr 03 13:47:49 sibermusic kernel: pci 0000:01:00.0: PME# supported from D0 D3cold Apr 03 13:47:49 sibermusic kernel: PCI: bus1: Fast back to back transfers disabled Apr 03 13:47:49 sibermusic kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 Apr 03 13:47:49 sibermusic kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] Apr 03 13:47:49 sibermusic kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] Apr 03 13:47:49 sibermusic kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Apr 03 13:47:49 sibermusic kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] Apr 03 13:47:49 sibermusic kernel: pcieport 0000:00:00.0: enabling device (0000 -> 0002) Apr 03 13:47:49 sibermusic kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 45 Apr 03 13:47:49 sibermusic kernel: bcm2708_fb soc:fb: FB found 1 display(s) Apr 03 13:47:49 sibermusic kernel: Console: switching to colour frame buffer device 100x30 Apr 03 13:47:49 sibermusic kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 800x480 Apr 03 13:47:49 sibermusic kernel: iproc-rng200 fe104000.rng: hwrng registered Apr 03 13:47:49 sibermusic kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Apr 03 13:47:49 sibermusic kernel: brd: module loaded Apr 03 13:47:49 sibermusic kernel: loop: module loaded Apr 03 13:47:49 sibermusic kernel: Loading iSCSI transport class v2.0-870. Apr 03 13:47:49 sibermusic kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 Apr 03 13:47:49 sibermusic kernel: Freeing initrd memory: 13628K Apr 03 13:47:49 sibermusic kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus Apr 03 13:47:49 sibermusic kernel: usbcore: registered new device driver r8152-cfgselector Apr 03 13:47:49 sibermusic kernel: usbcore: registered new interface driver r8152 Apr 03 13:47:49 sibermusic kernel: usbcore: registered new interface driver lan78xx Apr 03 13:47:49 sibermusic kernel: usbcore: registered new interface driver smsc95xx Apr 03 13:47:49 sibermusic kernel: xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142) Apr 03 13:47:49 sibermusic kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Apr 03 13:47:49 sibermusic kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 Apr 03 13:47:49 sibermusic kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0b00040000000890 Apr 03 13:47:49 sibermusic kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Apr 03 13:47:49 sibermusic kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 Apr 03 13:47:49 sibermusic kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed Apr 03 13:47:49 sibermusic kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01 Apr 03 13:47:49 sibermusic kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Apr 03 13:47:49 sibermusic kernel: usb usb1: Product: xHCI Host Controller Apr 03 13:47:49 sibermusic kernel: usb usb1: Manufacturer: Linux 6.1.69-v7l+ xhci-hcd Apr 03 13:47:49 sibermusic kernel: usb usb1: SerialNumber: 0000:01:00.0 Apr 03 13:47:49 sibermusic kernel: hub 1-0:1.0: USB hub found Apr 03 13:47:49 sibermusic kernel: hub 1-0:1.0: 1 port detected Apr 03 13:47:49 sibermusic kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01 Apr 03 13:47:49 sibermusic kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Apr 03 13:47:49 sibermusic kernel: usb usb2: Product: xHCI Host Controller Apr 03 13:47:49 sibermusic kernel: usb usb2: Manufacturer: Linux 6.1.69-v7l+ xhci-hcd Apr 03 13:47:49 sibermusic kernel: usb usb2: SerialNumber: 0000:01:00.0 Apr 03 13:47:49 sibermusic kernel: hub 2-0:1.0: USB hub found Apr 03 13:47:49 sibermusic kernel: hub 2-0:1.0: 4 ports detected Apr 03 13:47:49 sibermusic kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Apr 03 13:47:49 sibermusic kernel: dwc_otg: FIQ enabled Apr 03 13:47:49 sibermusic kernel: dwc_otg: NAK holdoff enabled Apr 03 13:47:49 sibermusic kernel: dwc_otg: FIQ split-transaction FSM enabled Apr 03 13:47:49 sibermusic kernel: Module dwc_common_port init Apr 03 13:47:49 sibermusic kernel: usbcore: registered new interface driver uas Apr 03 13:47:49 sibermusic kernel: usbcore: registered new interface driver usb-storage Apr 03 13:47:49 sibermusic kernel: mousedev: PS/2 mouse device common for all mice Apr 03 13:47:49 sibermusic kernel: sdhci: Secure Digital Host Controller Interface driver Apr 03 13:47:49 sibermusic kernel: sdhci: Copyright(c) Pierre Ossman Apr 03 13:47:49 sibermusic kernel: sdhci-pltfm: SDHCI platform and OF driver helper Apr 03 13:47:49 sibermusic kernel: ledtrig-cpu: registered to indicate activity on CPUs Apr 03 13:47:49 sibermusic kernel: hid: raw HID events driver (C) Jiri Kosina Apr 03 13:47:49 sibermusic kernel: usbcore: registered new interface driver usbhid Apr 03 13:47:49 sibermusic kernel: usbhid: USB HID core driver Apr 03 13:47:49 sibermusic kernel: Initializing XFRM netlink socket Apr 03 13:47:49 sibermusic kernel: NET: Registered PF_PACKET protocol family Apr 03 13:47:49 sibermusic kernel: Key type dns_resolver registered Apr 03 13:47:49 sibermusic kernel: Registering SWP/SWPB emulation handler Apr 03 13:47:49 sibermusic kernel: registered taskstats version 1 Apr 03 13:47:49 sibermusic kernel: Loading compiled-in X.509 certificates Apr 03 13:47:49 sibermusic kernel: Key type .fscrypt registered Apr 03 13:47:49 sibermusic kernel: Key type fscrypt-provisioning registered Apr 03 13:47:49 sibermusic kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Apr 03 13:47:49 sibermusic kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Apr 03 13:47:49 sibermusic kernel: fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 51, base_baud = 0) is a PL011 rev2 Apr 03 13:47:49 sibermusic kernel: serial serial0: tty port ttyAMA1 registered Apr 03 13:47:49 sibermusic kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Apr 03 13:47:49 sibermusic kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Apr 03 13:47:49 sibermusic kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Apr 03 13:47:49 sibermusic kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Apr 03 13:47:49 sibermusic kernel: of_cfs_init Apr 03 13:47:49 sibermusic kernel: of_cfs_init: OK Apr 03 13:47:49 sibermusic kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Apr 03 13:47:49 sibermusic kernel: Freeing unused kernel image (initmem) memory: 2048K Apr 03 13:47:49 sibermusic kernel: Run /init as init process Apr 03 13:47:49 sibermusic kernel: with arguments: Apr 03 13:47:49 sibermusic kernel: /init Apr 03 13:47:49 sibermusic kernel: splash Apr 03 13:47:49 sibermusic kernel: with environment: Apr 03 13:47:49 sibermusic kernel: HOME=/ Apr 03 13:47:49 sibermusic kernel: TERM=linux Apr 03 13:47:49 sibermusic kernel: imgpart=/dev/mmcblk0p2 Apr 03 13:47:49 sibermusic kernel: imgfile=/volumio_current.sqsh Apr 03 13:47:49 sibermusic kernel: bootdelay=5 Apr 03 13:47:49 sibermusic kernel: mmc1: new high speed SDIO card at address 0001 Apr 03 13:47:49 sibermusic kernel: mmc0: new ultra high speed DDR50 SDHC card at address 0007 Apr 03 13:47:49 sibermusic kernel: mmcblk0: mmc0:0007 SD8GB 7.42 GiB Apr 03 13:47:49 sibermusic kernel: mmcblk0: p1 p2 p3 Apr 03 13:47:49 sibermusic kernel: mmcblk0: mmc0:0007 SD8GB 7.42 GiB Apr 03 13:47:49 sibermusic kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Apr 03 13:47:49 sibermusic initramfs: Booting Volumio for BCM2711 Apr 03 13:47:49 sibermusic initramfs: This script mounts rootfs RO with an overlay RW layer. Apr 03 13:47:49 sibermusic kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 03 13:47:49 sibermusic initramfs: IMGPART=/dev/mmcblk0p2 Apr 03 13:47:49 sibermusic initramfs: IMGFILE=/volumio_current.sqsh Apr 03 13:47:49 sibermusic initramfs: Boot delay (except first time) will be 5 seconds Apr 03 13:47:49 sibermusic initramfs: /dev/mmcblk0p2: Apr 03 13:47:49 sibermusic kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Apr 03 13:47:49 sibermusic kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Apr 03 13:47:49 sibermusic kernel: usb 1-1: Product: USB2.0 Hub Apr 03 13:47:49 sibermusic kernel: hub 1-1:1.0: USB hub found Apr 03 13:47:49 sibermusic kernel: hub 1-1:1.0: 4 ports detected Apr 03 13:47:49 sibermusic kernel: usb 1-1.1: new high-speed USB device number 3 using xhci_hcd Apr 03 13:47:49 sibermusic kernel: usb 1-1.1: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 1.04 Apr 03 13:47:49 sibermusic kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 03 13:47:49 sibermusic kernel: usb 1-1.1: Product: D10s Apr 03 13:47:49 sibermusic kernel: usb 1-1.1: Manufacturer: Topping Apr 03 13:47:49 sibermusic kernel: EXT4-fs (mmcblk0p2): recovery complete Apr 03 13:47:49 sibermusic kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. Apr 03 13:47:49 sibermusic initramfs: Doing a 5 second delay here to give kernel load a headstart Apr 03 13:47:49 sibermusic initramfs: Checking for USB updates Apr 03 13:47:49 sibermusic initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Apr 03 13:47:49 sibermusic kernel: loop0: detected capacity change from 0 to 967536 Apr 03 13:47:49 sibermusic kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Apr 03 13:47:49 sibermusic kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Apr 03 13:47:49 sibermusic kernel: EXT4-fs (mmcblk0p3): recovery complete Apr 03 13:47:49 sibermusic kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. Apr 03 13:47:49 sibermusic initramfs: With Option: Apr 03 13:47:49 sibermusic initramfs: VOLUMIO_VERSION="3.631" Apr 03 13:47:49 sibermusic initramfs: Finish initramfs, continue booting Volumio Apr 03 13:47:49 sibermusic systemd[1]: System time before build time, advancing clock. Apr 03 13:47:49 sibermusic kernel: NET: Registered PF_INET6 protocol family Apr 03 13:47:49 sibermusic kernel: Segment Routing with IPv6 Apr 03 13:47:49 sibermusic kernel: In-situ OAM (IOAM) with IPv6 Apr 03 13:47:49 sibermusic systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Apr 03 13:47:49 sibermusic systemd[1]: Detected architecture arm. Apr 03 13:47:49 sibermusic systemd[1]: Set hostname to . Apr 03 13:47:49 sibermusic systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 03 13:47:49 sibermusic systemd[1]: Created slice User and Session Slice. Apr 03 13:47:49 sibermusic systemd[1]: Reached target Slices. Apr 03 13:47:49 sibermusic systemd[1]: Listening on RPCbind Server Activation Socket. Apr 03 13:47:49 sibermusic systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Apr 03 13:47:49 sibermusic systemd[1]: Listening on Journal Audit Socket. Apr 03 13:47:49 sibermusic systemd[1]: Reached target System Time Synchronized. Apr 03 13:47:49 sibermusic kernel: i2c_dev: i2c /dev entries driver Apr 03 13:47:49 sibermusic systemd-journald[210]: Journal started Apr 03 13:47:49 sibermusic systemd-journald[210]: Runtime journal (/run/log/journal/4ceeebcde4a5f04b591e77826532825c) is 3.7M, max 30.0M, 26.2M free. Feb 14 11:11:59 sibermusic systemd-modules-load[206]: Inserted module 'i2c_dev' Apr 03 13:47:49 sibermusic fake-hwclock[204]: Wed Apr 3 11:47:49 UTC 2024 Apr 03 13:47:49 sibermusic systemd[1]: Started Apply Kernel Variables. Apr 03 13:47:49 sibermusic systemd[1]: Started Create System Users. Apr 03 13:47:49 sibermusic systemd[1]: Starting Create Static Device Nodes in /dev... Apr 03 13:47:49 sibermusic systemd[1]: Started udev Coldplug all Devices. Apr 03 13:47:49 sibermusic systemd[1]: Starting Helper to synchronize boot up for ifupdown... Apr 03 13:47:49 sibermusic systemd[1]: Started Create Static Device Nodes in /dev. Apr 03 13:47:49 sibermusic systemd[1]: Reached target Local File Systems (Pre). Apr 03 13:47:49 sibermusic systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Apr 03 13:47:49 sibermusic systemd[1]: Mounting /tmp... Apr 03 13:47:49 sibermusic systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Apr 03 13:47:49 sibermusic systemd[1]: Mounting /var/log... Apr 03 13:47:49 sibermusic systemd[1]: Mounting /var/spool/cups... Apr 03 13:47:49 sibermusic systemd[1]: Starting udev Kernel Device Manager... Apr 03 13:47:49 sibermusic systemd[1]: Started Helper to synchronize boot up for ifupdown. Apr 03 13:47:49 sibermusic systemd[1]: Mounted /tmp. Apr 03 13:47:49 sibermusic systemd[1]: Mounted /var/log. Apr 03 13:47:49 sibermusic systemd[1]: Mounted /var/spool/cups. Apr 03 13:47:49 sibermusic systemd[1]: Mounting /var/spool/cups/tmp... Apr 03 13:47:49 sibermusic systemd[1]: Starting Flush Journal to Persistent Storage... Apr 03 13:47:49 sibermusic systemd[1]: Mounted /var/spool/cups/tmp. Apr 03 13:47:49 sibermusic systemd-udevd[235]: Network interface NamePolicy= disabled on kernel command line, ignoring. Apr 03 13:47:49 sibermusic systemd-journald[210]: Runtime journal (/run/log/journal/4ceeebcde4a5f04b591e77826532825c) is 3.7M, max 30.0M, 26.2M free. Apr 03 13:47:49 sibermusic systemd[1]: Started Flush Journal to Persistent Storage. Apr 03 13:47:49 sibermusic systemd[1]: Started udev Kernel Device Manager. Apr 03 13:47:49 sibermusic systemd[1]: Starting Show Plymouth Boot Screen... Apr 03 13:47:49 sibermusic systemd[1]: Received SIGRTMIN+20 from PID 261 (plymouthd). Apr 03 13:47:49 sibermusic systemd[1]: Started Show Plymouth Boot Screen. Apr 03 13:47:49 sibermusic systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 03 13:47:49 sibermusic systemd[1]: Reached target Local Encrypted Volumes. Apr 03 13:47:49 sibermusic systemd[1]: Reached target Paths. Apr 03 13:47:49 sibermusic systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Apr 03 13:47:49 sibermusic systemd-udevd[242]: Using default interface naming scheme 'v240'. Apr 03 13:47:49 sibermusic kernel: rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000 Apr 03 13:47:49 sibermusic kernel: rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem Apr 03 13:47:49 sibermusic systemd-udevd[242]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 03 13:47:49 sibermusic kernel: mc: Linux media interface: v0.10 Apr 03 13:47:50 sibermusic kernel: input: raspberrypi-ts as /devices/platform/soc/soc:firmware/soc:firmware:touchscreen/input/input0 Apr 03 13:47:50 sibermusic kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Apr 03 13:47:50 sibermusic kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Apr 03 13:47:50 sibermusic kernel: [vc_sm_connected_init]: start Apr 03 13:47:50 sibermusic kernel: [vc_sm_connected_init]: installed successfully Apr 03 13:47:50 sibermusic kernel: videodev: Linux video capture interface: v2.00 Apr 03 13:47:50 sibermusic systemd-udevd[268]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 03 13:47:50 sibermusic kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Apr 03 13:47:50 sibermusic kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Apr 03 13:47:50 sibermusic kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Apr 03 13:47:50 sibermusic kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Apr 03 13:47:50 sibermusic kernel: rpivid feb10000.codec: Device registered as /dev/video19 Apr 03 13:47:50 sibermusic kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Apr 03 13:47:50 sibermusic kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Apr 03 13:47:50 sibermusic kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Apr 03 13:47:50 sibermusic kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Apr 03 13:47:50 sibermusic kernel: bcm2835_audio bcm2835_audio: card created with 8 channels Apr 03 13:47:50 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Apr 03 13:47:50 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Apr 03 13:47:50 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Apr 03 13:47:50 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Apr 03 13:47:50 sibermusic kernel: Bluetooth: Core ver 2.22 Apr 03 13:47:50 sibermusic kernel: NET: Registered PF_BLUETOOTH protocol family Apr 03 13:47:50 sibermusic kernel: Bluetooth: HCI device and connection manager initialized Apr 03 13:47:50 sibermusic kernel: Bluetooth: HCI socket layer initialized Apr 03 13:47:50 sibermusic kernel: Bluetooth: L2CAP socket layer initialized Apr 03 13:47:50 sibermusic kernel: Bluetooth: SCO socket layer initialized Apr 03 13:47:50 sibermusic kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Apr 03 13:47:50 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Apr 03 13:47:50 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Apr 03 13:47:50 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Apr 03 13:47:50 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Apr 03 13:47:50 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Apr 03 13:47:50 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Apr 03 13:47:51 sibermusic kernel: Bluetooth: HCI UART driver ver 2.3 Apr 03 13:47:51 sibermusic kernel: Bluetooth: HCI UART protocol H4 registered Apr 03 13:47:51 sibermusic kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Apr 03 13:47:51 sibermusic kernel: Bluetooth: HCI UART protocol Broadcom registered Apr 03 13:47:51 sibermusic kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Apr 03 13:47:51 sibermusic kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Apr 03 13:47:51 sibermusic kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Apr 03 13:47:51 sibermusic kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Apr 03 13:47:51 sibermusic kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Apr 03 13:47:51 sibermusic kernel: uart-pl011 fe201000.serial: no DMA platform data Apr 03 13:47:51 sibermusic kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000 Apr 03 13:47:51 sibermusic kernel: usbcore: registered new interface driver snd-usb-audio Apr 03 13:47:51 sibermusic kernel: Bluetooth: hci0: BCM: chip id 107 Apr 03 13:47:51 sibermusic kernel: Bluetooth: hci0: BCM: features 0x2f Apr 03 13:47:51 sibermusic kernel: Bluetooth: hci0: BCM4345C0 Apr 03 13:47:51 sibermusic kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Apr 03 13:47:51 sibermusic kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Apr 03 13:47:51 sibermusic kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Apr 03 13:47:51 sibermusic kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Apr 03 13:47:51 sibermusic kernel: usbcore: registered new interface driver brcmfmac Apr 03 13:47:51 sibermusic systemd-udevd[251]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 03 13:47:51 sibermusic systemd-udevd[269]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 03 13:47:51 sibermusic kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 Apr 03 13:47:52 sibermusic systemd-udevd[266]: Using default interface naming scheme 'v240'. Apr 03 13:47:52 sibermusic systemd-udevd[266]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 03 13:47:52 sibermusic kernel: Bluetooth: hci0: BCM: features 0x2f Apr 03 13:47:52 sibermusic kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Apr 03 13:47:52 sibermusic kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Apr 03 13:47:52 sibermusic systemd-udevd[251]: Process '/sbin/crda' failed with exit code 255. Apr 03 13:47:53 sibermusic systemd-udevd[258]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Apr 03 13:47:53 sibermusic systemd[1]: Found device /dev/mmcblk0p1. Apr 03 13:47:53 sibermusic systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Apr 03 13:47:53 sibermusic systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. Apr 03 13:47:53 sibermusic systemd[1]: Created slice system-bthelper.slice. Apr 03 13:47:53 sibermusic systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Apr 03 13:47:53 sibermusic systemd[1]: Condition check resulted in Huge Pages File System being skipped. Apr 03 13:47:53 sibermusic systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 03 13:47:53 sibermusic systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Apr 03 13:47:53 sibermusic systemd[1]: Condition check resulted in FUSE Control File System being skipped. Apr 03 13:47:53 sibermusic systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Apr 03 13:47:53 sibermusic systemd[1]: Created slice system-systemd\x2dbacklight.slice. Apr 03 13:47:53 sibermusic systemd[1]: Starting Load/Save Screen Backlight Brightness of backlight:rpi_backlight... Apr 03 13:47:54 sibermusic systemd[1]: Starting File System Check on /dev/mmcblk0p1... Apr 03 13:47:54 sibermusic systemd[1]: Starting Load/Save RF Kill Switch Status... Apr 03 13:47:54 sibermusic systemd[1]: Started Load/Save Screen Backlight Brightness of backlight:rpi_backlight. Apr 03 13:47:54 sibermusic systemd[1]: Started File System Check Daemon to report status. Apr 03 13:47:54 sibermusic systemd[1]: Started Load/Save RF Kill Switch Status. Apr 03 13:47:54 sibermusic systemd-fsck[399]: fsck.fat 4.1 (2017-01-24) Apr 03 13:47:54 sibermusic systemd-fsck[399]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Apr 03 13:47:54 sibermusic systemd-fsck[399]: Automatically removing dirty bit. Apr 03 13:47:54 sibermusic systemd-fsck[399]: Performing changes. Apr 03 13:47:54 sibermusic systemd-fsck[399]: /dev/mmcblk0p1: 367 files, 33349/46774 clusters Apr 03 13:47:54 sibermusic systemd[1]: Started File System Check on /dev/mmcblk0p1. Apr 03 13:47:54 sibermusic systemd[1]: Mounting /boot... Apr 03 13:47:54 sibermusic systemd[1]: Mounted /boot. Apr 03 13:47:54 sibermusic systemd[1]: Reached target Local File Systems. Apr 03 13:47:54 sibermusic systemd[1]: Starting Create Volatile Files and Directories... Apr 03 13:47:54 sibermusic systemd[1]: Started ifup for wlan0. Apr 03 13:47:54 sibermusic systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Apr 03 13:47:54 sibermusic systemd[1]: Starting Raise network interfaces... Apr 03 13:47:54 sibermusic systemd[1]: Starting Preprocess NFS configuration... Apr 03 13:47:54 sibermusic systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Apr 03 13:47:54 sibermusic systemd[1]: Started ifup for eth0. Apr 03 13:47:54 sibermusic systemd[1]: Received SIGRTMIN+20 from PID 261 (plymouthd). Apr 03 13:47:54 sibermusic systemd[1]: plymouth-read-write.service: Succeeded. Apr 03 13:47:54 sibermusic systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Apr 03 13:47:54 sibermusic systemd[1]: nfs-config.service: Succeeded. Apr 03 13:47:54 sibermusic systemd[1]: Started Preprocess NFS configuration. Apr 03 13:47:54 sibermusic systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Apr 03 13:47:54 sibermusic systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Apr 03 13:47:54 sibermusic systemd[1]: Reached target NFS client services. Apr 03 13:47:54 sibermusic systemd[1]: Started Create Volatile Files and Directories. Apr 03 13:47:54 sibermusic systemd[1]: Starting RPC bind portmap service... Apr 03 13:47:54 sibermusic systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Apr 03 13:47:54 sibermusic systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Apr 03 13:47:54 sibermusic systemd[1]: Starting Update UTMP about System Boot/Shutdown... Apr 03 13:47:54 sibermusic systemd[1]: Started Update UTMP about System Boot/Shutdown. Apr 03 13:47:54 sibermusic systemd[1]: Reached target System Initialization. Apr 03 13:47:55 sibermusic systemd[1]: man-db.timer: Not using persistent file timestamp Sun 2024-04-07 00:00:24 CEST as it is in the future. Apr 03 13:47:55 sibermusic systemd[1]: Started Daily man-db regeneration. Apr 03 13:47:55 sibermusic systemd[1]: Listening on triggerhappy.socket. Apr 03 13:47:55 sibermusic systemd[1]: apt-daily.timer: Not using persistent file timestamp Sun 2024-04-07 14:07:24 CEST as it is in the future. Apr 03 13:47:55 sibermusic systemd[1]: Started Daily apt download activities. Apr 03 13:47:55 sibermusic systemd[1]: Listening on lircd.socket. Apr 03 13:47:55 sibermusic systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Apr 03 13:47:55 sibermusic systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Sun 2024-04-07 06:12:14 CEST as it is in the future. Apr 03 13:47:55 sibermusic systemd[1]: Started Daily apt upgrade and clean activities. Apr 03 13:47:55 sibermusic systemd[1]: Started Daily Cleanup of Temporary Directories. Apr 03 13:47:55 sibermusic systemd[1]: Reached target Timers. Apr 03 13:47:55 sibermusic systemd[1]: Listening on D-Bus System Message Bus Socket. Apr 03 13:47:55 sibermusic kernel: 8021q: 802.1Q VLAN Support v1.8 Apr 03 13:47:55 sibermusic systemd[1]: Reached target Sockets. Apr 03 13:47:55 sibermusic kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 03 13:47:55 sibermusic systemd[1]: Started Volumio Splash. Apr 03 13:47:55 sibermusic systemd[1]: Reached target Basic System. Apr 03 13:47:55 sibermusic systemd[1]: Started UPnP Renderer front-end to MPD. Apr 03 13:47:55 sibermusic systemd[487]: volumiosplash.service: Failed to execute command: No such file or directory Apr 03 13:47:55 sibermusic systemd[487]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory Apr 03 13:47:55 sibermusic systemd[1]: Started Volumio Iptables Module. Apr 03 13:47:55 sibermusic systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Apr 03 13:47:55 sibermusic systemd[1]: Starting Login Service... Apr 03 13:47:55 sibermusic systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Apr 03 13:47:55 sibermusic systemd[1]: Started D-Bus System Message Bus. Apr 03 13:47:55 sibermusic systemd[1]: Starting WPA supplicant... Apr 03 13:47:55 sibermusic systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Apr 03 13:47:55 sibermusic systemd[1]: Started volumio-remote-updater.service. Apr 03 13:47:55 sibermusic systemd[1]: Started Manage Sound Card State (restore and store). Apr 03 13:47:55 sibermusic systemd[1]: Starting Save/Restore Sound Card State... Apr 03 13:47:55 sibermusic alsactl[521]: alsactl 1.1.8 daemon started Apr 03 13:47:55 sibermusic systemd[1]: Starting Wireless Services... Apr 03 13:47:55 sibermusic systemd[1]: Starting dhcpcd on all interfaces... Apr 03 13:47:55 sibermusic systemd[1]: Started Volumio Log Rotation Service. Apr 03 13:47:55 sibermusic dhcpcd[529]: Not running dhcpcd because /etc/network/interfaces Apr 03 13:47:55 sibermusic dhcpcd[529]: defines some interfaces that will use a Apr 03 13:47:55 sibermusic dhcpcd[529]: DHCP client or static address Apr 03 13:47:55 sibermusic sh[417]: eth0: waiting for carrier Apr 03 13:47:55 sibermusic kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Apr 03 13:47:55 sibermusic kernel: bcmgenet fd580000.ethernet eth0: Link is Down Apr 03 13:47:55 sibermusic dhcpcd[454]: eth0: waiting for carrier Apr 03 13:47:55 sibermusic systemd[1]: Starting Configure Bluetooth Modems connected by UART... Apr 03 13:47:55 sibermusic systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 03 13:47:55 sibermusic systemd[1]: Starting triggerhappy global hotkey daemon... Apr 03 13:47:55 sibermusic systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Apr 03 13:47:55 sibermusic systemd[1]: Reached target Login Prompts. Apr 03 13:47:55 sibermusic systemd-logind[508]: New seat seat0. Apr 03 13:47:55 sibermusic systemd[1]: Starting Set local time using time server... Apr 03 13:47:55 sibermusic systemd[1]: Started RPC bind portmap service. Apr 03 13:47:55 sibermusic systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC Apr 03 13:47:55 sibermusic systemd[1]: volumiosplash.service: Failed with result 'exit-code'. Apr 03 13:47:55 sibermusic systemd[1]: Started Save/Restore Sound Card State. Apr 03 13:47:55 sibermusic avahi-daemon[510]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Apr 03 13:47:55 sibermusic avahi-daemon[510]: Successfully dropped root privileges. Apr 03 13:47:55 sibermusic avahi-daemon[510]: avahi-daemon 0.7 starting up. Apr 03 13:47:55 sibermusic systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Apr 03 13:47:55 sibermusic systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Apr 03 13:47:55 sibermusic systemd[1]: Failed to start dhcpcd on all interfaces. Apr 03 13:47:55 sibermusic systemd[1]: Reached target Sound Card. Apr 03 13:47:55 sibermusic systemd[1]: Reached target Remote File Systems (Pre). Apr 03 13:47:55 sibermusic systemd[1]: Reached target Remote File Systems. Apr 03 13:47:56 sibermusic systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Apr 03 13:47:56 sibermusic systemd[1]: Reached target RPC Port Mapper. Apr 03 13:47:56 sibermusic sh[407]: wlan0=wlan0 Apr 03 13:47:56 sibermusic thd[536]: Unable to parse trigger line: Apr 03 13:47:56 sibermusic thd[536]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Apr 03 13:47:56 sibermusic thd[536]: Unable to parse trigger line: Apr 03 13:47:56 sibermusic thd[536]: Unable to parse trigger line: Apr 03 13:47:56 sibermusic thd[536]: Unable to parse trigger line: Apr 03 13:47:56 sibermusic thd[536]: Unable to parse trigger line: Apr 03 13:47:56 sibermusic thd[536]: Unable to parse trigger line: Apr 03 13:47:56 sibermusic thd[536]: Unable to parse trigger line: Apr 03 13:47:56 sibermusic thd[536]: Found socket passed from systemd Apr 03 13:47:56 sibermusic volumio-remote-updater[520]: Error: No active session Apr 03 13:47:56 sibermusic volumio-remote-updater[520]: [2024-04-03 13:47:56] [info] asio async_connect error: system:111 (Connection refused) Apr 03 13:47:56 sibermusic volumio-remote-updater[520]: [2024-04-03 13:47:56] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 03 13:47:56 sibermusic volumio-remote-updater[520]: [2024-04-03 13:47:56] [error] handle_connect error: Underlying Transport Error Apr 03 13:47:56 sibermusic volumio[501]: Could not open config: /tmp/upmpdcli.conf Apr 03 13:47:56 sibermusic dbus-daemon[511]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 03 13:47:56 sibermusic systemd[1]: Started Login Service. Apr 03 13:47:56 sibermusic systemd[1]: Started triggerhappy global hotkey daemon. Apr 03 13:47:56 sibermusic systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:47:56 sibermusic systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 13:47:56 sibermusic wpa_supplicant[519]: Successfully initialized wpa_supplicant Apr 03 13:47:56 sibermusic systemd[1]: hciuart.service: Succeeded. Apr 03 13:47:56 sibermusic systemd[1]: Started Configure Bluetooth Modems connected by UART. Apr 03 13:47:56 sibermusic avahi-daemon[510]: Successfully called chroot(). Apr 03 13:47:56 sibermusic avahi-daemon[510]: Successfully dropped remaining capabilities. Apr 03 13:47:56 sibermusic avahi-daemon[510]: Loading service file /services/volumio.service. Apr 03 13:47:56 sibermusic avahi-daemon[510]: Network interface enumeration completed. Apr 03 13:47:56 sibermusic avahi-daemon[510]: Server startup complete. Host name is sibermusic.local. Local service cookie is 1049142776. Apr 03 13:47:56 sibermusic avahi-daemon[510]: Service "sibermusic" (/services/volumio.service) successfully established. Apr 03 13:47:56 sibermusic systemd[1]: Started Raise network interfaces. Apr 03 13:47:56 sibermusic systemd[1]: Started WPA supplicant. Apr 03 13:47:56 sibermusic systemd[1]: Started Avahi mDNS/DNS-SD Stack. Apr 03 13:47:56 sibermusic systemd[1]: Reached target Network. Apr 03 13:47:56 sibermusic systemd[1]: Starting Network Time Service... Apr 03 13:47:56 sibermusic systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Apr 03 13:47:56 sibermusic systemd[1]: Starting OpenBSD Secure Shell server... Apr 03 13:47:56 sibermusic systemd[1]: Starting Permit User Sessions... Apr 03 13:47:56 sibermusic systemd[1]: Reached target Network is Online. Apr 03 13:47:56 sibermusic systemd[1]: Starting LSB: Brings up/down network automatically... Apr 03 13:47:56 sibermusic systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 03 13:47:56 sibermusic systemd[1]: Starting /etc/rc.local Compatibility... Apr 03 13:47:56 sibermusic systemd[1]: Starting Samba NMB Daemon... Apr 03 13:47:57 sibermusic systemd[1]: Starting Raspberry Pi bluetooth helper... Apr 03 13:47:57 sibermusic systemd[1]: Started Permit User Sessions. Apr 03 13:47:57 sibermusic bthelper[617]: Raspberry Pi BDADDR already set Apr 03 13:47:57 sibermusic systemd[1]: iptables.service: Succeeded. Apr 03 13:47:57 sibermusic systemd[1]: Started Raspberry Pi bluetooth helper. Apr 03 13:47:57 sibermusic systemd[1]: Starting Bluetooth service... Apr 03 13:47:57 sibermusic ifplugd(eth0)[670]: ifplugd 0.28 initializing. Apr 03 13:47:57 sibermusic ifplugd(eth0)[670]: Using interface eth0/DC:A6:32:6C:7A:FC with driver (version: 6.1.69-v7l+) Apr 03 13:47:57 sibermusic ifplugd(eth0)[670]: Using detection mode: SIOCETHTOOL Apr 03 13:47:57 sibermusic ifplugd(eth0)[670]: Initialization complete, link beat not detected. Apr 03 13:47:57 sibermusic loadcpufreq[546]: Loading cpufreq kernel modules...done (none). Apr 03 13:47:57 sibermusic systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Apr 03 13:47:57 sibermusic systemd[1]: Starting LSB: set CPUFreq kernel parameters... Apr 03 13:47:57 sibermusic sshd[657]: Server listening on 0.0.0.0 port 22. Apr 03 13:47:57 sibermusic sshd[657]: Server listening on :: port 22. Apr 03 13:47:57 sibermusic systemd[1]: Started OpenBSD Secure Shell server. Apr 03 13:47:57 sibermusic ifplugd[609]: Network Interface Plugging Daemon...start eth0...done. Apr 03 13:47:57 sibermusic systemd[1]: Started LSB: Brings up/down network automatically. Apr 03 13:47:57 sibermusic ntpd[602]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 03 13:47:57 sibermusic ntpd[602]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Apr 03 13:47:57 sibermusic ntpd[674]: proto: precision = 2.167 usec (-19) Apr 03 13:47:57 sibermusic systemd[1]: Started Network Time Service. Apr 03 13:47:57 sibermusic ntpd[674]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 03 13:47:57 sibermusic ntpd[674]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 03 13:47:57 sibermusic ntpd[674]: Listen and drop on 0 v6wildcard [::]:123 Apr 03 13:47:57 sibermusic ntpd[674]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 03 13:47:57 sibermusic ntpd[674]: Listen normally on 2 lo 127.0.0.1:123 Apr 03 13:47:57 sibermusic ntpd[674]: Listening on routing socket on fd #19 for interface updates Apr 03 13:47:57 sibermusic ntpd[674]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 03 13:47:57 sibermusic ntpd[674]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 03 13:47:57 sibermusic cpufrequtils[671]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Apr 03 13:47:57 sibermusic systemd[1]: Started LSB: set CPUFreq kernel parameters. Apr 03 13:47:57 sibermusic bluetoothd[663]: Bluetooth daemon 5.50 Apr 03 13:47:57 sibermusic bluetoothd[663]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Apr 03 13:47:57 sibermusic systemd[1]: Started Bluetooth service. Apr 03 13:47:57 sibermusic systemd[1]: Reached target Bluetooth. Apr 03 13:47:57 sibermusic bluetoothd[663]: Starting SDP server Apr 03 13:47:57 sibermusic bluetoothd[663]: Excluding (cli) sap Apr 03 13:47:57 sibermusic bluetoothd[663]: Bluetooth management interface 1.22 initialized Apr 03 13:47:57 sibermusic dbus-daemon[511]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=663 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Apr 03 13:47:57 sibermusic kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Apr 03 13:47:57 sibermusic kernel: Bluetooth: BNEP filters: protocol multicast Apr 03 13:47:57 sibermusic kernel: Bluetooth: BNEP socket layer initialized Apr 03 13:47:57 sibermusic kernel: Bluetooth: MGMT ver 1.22 Apr 03 13:47:57 sibermusic sudo[632]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh -c echo 0 > /sys/class/leds/PWR/brightness Apr 03 13:47:57 sibermusic sudo[632]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:47:58 sibermusic sudo[632]: pam_unix(sudo:session): session closed for user root Apr 03 13:47:58 sibermusic bluetoothd[663]: Failed to set privacy: Rejected (0x0b) Apr 03 13:47:58 sibermusic systemd[1]: Started /etc/rc.local Compatibility. Apr 03 13:47:58 sibermusic systemd[1]: Starting Hold until boot process finishes up... Apr 03 13:47:58 sibermusic systemd[1]: Starting Terminate Plymouth Boot Screen... Apr 03 13:47:58 sibermusic systemd[1]: Starting Hostname Service... Apr 03 13:47:58 sibermusic systemd[1]: Received SIGRTMIN+21 from PID 261 (plymouthd). Apr 03 13:47:58 sibermusic systemd[1]: plymouth-quit-wait.service: Succeeded. Apr 03 13:47:58 sibermusic systemd[1]: Started Hold until boot process finishes up. Apr 03 13:47:58 sibermusic systemd[1]: plymouth-quit.service: Succeeded. Apr 03 13:47:58 sibermusic systemd[1]: Started Terminate Plymouth Boot Screen. Apr 03 13:47:58 sibermusic systemd[1]: Received SIGRTMIN+21 from PID 261 (plymouthd). Apr 03 13:47:58 sibermusic systemd[1]: plymouth-start.service: Succeeded. Apr 03 13:47:58 sibermusic haveged[466]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Apr 03 13:47:58 sibermusic haveged[466]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Apr 03 13:47:58 sibermusic haveged[466]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99467 Apr 03 13:47:58 sibermusic haveged[466]: haveged: fills: 0, generated: 0 Apr 03 13:47:58 sibermusic dbus-daemon[511]: [system] Successfully activated service 'org.freedesktop.hostname1' Apr 03 13:47:58 sibermusic systemd[1]: Started Hostname Service. Apr 03 13:47:58 sibermusic ntpd[674]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 03 13:47:58 sibermusic nmbd[624]: [2024/04/03 13:47:58.653872, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Apr 03 13:47:58 sibermusic nmbd[624]: started asyncdns process 699 Apr 03 13:47:58 sibermusic nmbd[624]: [2024/04/03 13:47:58.656250, 0] ../lib/util/become_daemon.c:149(daemon_status) Apr 03 13:47:58 sibermusic nmbd[624]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Apr 03 13:47:58 sibermusic nmbd[624]: [2024/04/03 13:47:58.656582, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Apr 03 13:47:58 sibermusic nmbd[624]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Apr 03 13:47:58 sibermusic kernel: new mount options do not match the existing superblock, will be ignored Apr 03 13:47:58 sibermusic wireless.js[525]: Cleaning previous... Apr 03 13:47:58 sibermusic volumio[535]: cset: --> shielding system active with Apr 03 13:47:58 sibermusic volumio[535]: cset: "system" cpuset of CPUSPEC(2-3) with 77 tasks running Apr 03 13:47:58 sibermusic volumio[535]: cset: "user" cpuset of CPUSPEC(0-1) with 0 tasks running Apr 03 13:47:58 sibermusic systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 03 13:47:59 sibermusic sudo[719]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 03 13:47:59 sibermusic sudo[719]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:47:59 sibermusic sudo[719]: pam_unix(sudo:session): session closed for user root Apr 03 13:47:59 sibermusic sudo[721]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 03 13:47:59 sibermusic sudo[721]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:47:59 sibermusic systemd[1]: systemd-rfkill.service: Succeeded. Apr 03 13:47:59 sibermusic sudo[721]: pam_unix(sudo:session): session closed for user root Apr 03 13:47:59 sibermusic ntpd[674]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 03 13:47:59 sibermusic wireless.js[525]: Stopped aP Apr 03 13:47:59 sibermusic sudo[728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 03 13:47:59 sibermusic sudo[728]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:47:59 sibermusic sudo[728]: pam_unix(sudo:session): session closed for user root Apr 03 13:47:59 sibermusic kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 03 13:47:59 sibermusic sudo[730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 03 13:47:59 sibermusic sudo[730]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:47:59 sibermusic sudo[730]: pam_unix(sudo:session): session closed for user root Apr 03 13:47:59 sibermusic sudo[737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 03 13:47:59 sibermusic sudo[737]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:47:59 sibermusic sudo[737]: pam_unix(sudo:session): session closed for user root Apr 03 13:47:59 sibermusic sudo[739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 03 13:47:59 sibermusic sudo[739]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:00 sibermusic ntpd[674]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Apr 03 13:48:01 sibermusic volumio-remote-updater[520]: [2024-04-03 13:48:01] [info] asio async_connect error: system:111 (Connection refused) Apr 03 13:48:01 sibermusic volumio-remote-updater[520]: [2024-04-03 13:48:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 03 13:48:01 sibermusic volumio-remote-updater[520]: [2024-04-03 13:48:01] [error] handle_connect error: Underlying Transport Error Apr 03 13:48:01 sibermusic ntpd[674]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Apr 03 13:48:02 sibermusic bthelper[617]: Changing power off succeeded Apr 03 13:48:02 sibermusic sudo[739]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:02 sibermusic wireless.js[525]: SETTING APPROPRIATE REG DOMAIN: DE Apr 03 13:48:02 sibermusic sudo[745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 03 13:48:02 sibermusic sudo[745]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:02 sibermusic sudo[745]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:02 sibermusic bthelper[617]: [CHG] Controller DC:A6:32:6C:7A:FE Class: 0x0000041c Apr 03 13:48:02 sibermusic bthelper[617]: Changing power on succeeded Apr 03 13:48:02 sibermusic sudo[751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Apr 03 13:48:02 sibermusic sudo[751]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:02 sibermusic sudo[751]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:02 sibermusic wireless.js[525]: SUCCESSFULLY SET NEW REGDOMAIN: DE Apr 03 13:48:02 sibermusic wireless.js[525]: Start wireless flow Apr 03 13:48:02 sibermusic wireless.js[525]: Stopped hotspot (if there).. Apr 03 13:48:02 sibermusic sudo[758]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 03 13:48:02 sibermusic sudo[758]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:02 sibermusic sudo[758]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:02 sibermusic sudo[760]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 03 13:48:02 sibermusic sudo[760]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:03 sibermusic sudo[760]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:03 sibermusic wireless.js[525]: DHCP IP Apr 03 13:48:03 sibermusic wireless.js[525]: Start ap Apr 03 13:48:03 sibermusic wpa_supplicant[762]: Successfully initialized wpa_supplicant Apr 03 13:48:03 sibermusic sudo[763]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 03 13:48:03 sibermusic sudo[763]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:03 sibermusic kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 03 13:48:03 sibermusic dhcpcd[764]: dev: loaded udev Apr 03 13:48:03 sibermusic dhcpcd-run-hooks[782]: wlan0: starting wpa_supplicant Apr 03 13:48:03 sibermusic dhcpcd-run-hooks[787]: wlan0: failed to start wpa_supplicant Apr 03 13:48:03 sibermusic dhcpcd-run-hooks[788]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Apr 03 13:48:03 sibermusic dhcpcd[764]: wlan0: connected to Access Point `' Apr 03 13:48:03 sibermusic dhcpcd[764]: no interfaces have a carrier Apr 03 13:48:03 sibermusic dhcpcd[764]: forked to background, child pid 798 Apr 03 13:48:03 sibermusic dhcpcd[798]: eth0: waiting for carrier Apr 03 13:48:03 sibermusic dhcpcd[798]: wlan0: waiting for carrier Apr 03 13:48:03 sibermusic sudo[763]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:04 sibermusic wireless.js[525]: trying... Apr 03 13:48:04 sibermusic sudo[800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:04 sibermusic sudo[800]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:04 sibermusic sudo[800]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:05 sibermusic wireless.js[525]: trying... Apr 03 13:48:05 sibermusic sudo[803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:05 sibermusic sudo[803]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:05 sibermusic sudo[803]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:05 sibermusic wpa_supplicant[786]: wlan0: Trying to associate with SSID 'Ziggy' Apr 03 13:48:06 sibermusic wireless.js[525]: trying... Apr 03 13:48:06 sibermusic sudo[806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:06 sibermusic sudo[806]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:06 sibermusic sudo[806]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:07 sibermusic wireless.js[525]: trying... Apr 03 13:48:07 sibermusic sudo[809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:07 sibermusic sudo[809]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:07 sibermusic sudo[809]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:08 sibermusic wireless.js[525]: trying... Apr 03 13:48:08 sibermusic sudo[812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:08 sibermusic sudo[812]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:08 sibermusic sudo[812]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:08 sibermusic dhcpcd[798]: wlan0: carrier acquired Apr 03 13:48:08 sibermusic dhcpcd[798]: wlan0: connected to Access Point `Ziggy' Apr 03 13:48:08 sibermusic wpa_supplicant[786]: wlan0: Associated with ac:22:05:46:79:f1 Apr 03 13:48:08 sibermusic wpa_supplicant[786]: wlan0: CTRL-EVENT-CONNECTED - Connection to ac:22:05:46:79:f1 completed [id=0 id_str=] Apr 03 13:48:08 sibermusic wpa_supplicant[786]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 03 13:48:08 sibermusic dhcpcd[798]: DUID 00:01:00:01:2c:c5:41:6b:e4:5f:01:7c:b5:70 Apr 03 13:48:08 sibermusic dhcpcd[798]: wlan0: IAID 32:6c:7a:fd Apr 03 13:48:08 sibermusic dhcpcd[798]: wlan0: adding address fe80::fcef:8611:26df:870e Apr 03 13:48:08 sibermusic dhcpcd[798]: ipv6_addaddr1: Permission denied Apr 03 13:48:08 sibermusic dhcpcd[798]: wlan0: carrier lost Apr 03 13:48:08 sibermusic dhcpcd[798]: wlan0: carrier acquired Apr 03 13:48:08 sibermusic systemd-udevd[815]: Process '/sbin/crda' failed with exit code 255. Apr 03 13:48:08 sibermusic dhcpcd[798]: wlan0: IAID 32:6c:7a:fd Apr 03 13:48:08 sibermusic volumio-remote-updater[520]: [2024-04-03 13:48:08] [info] asio async_connect error: system:111 (Connection refused) Apr 03 13:48:08 sibermusic volumio-remote-updater[520]: [2024-04-03 13:48:08] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 03 13:48:08 sibermusic volumio-remote-updater[520]: [2024-04-03 13:48:08] [error] handle_connect error: Underlying Transport Error Apr 03 13:48:09 sibermusic dhcpcd[798]: wlan0: rebinding lease of 192.168.178.227 Apr 03 13:48:09 sibermusic wireless.js[525]: trying... Apr 03 13:48:09 sibermusic sudo[829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:09 sibermusic sudo[829]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:09 sibermusic sudo[829]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:09 sibermusic dhcpcd[798]: wlan0: probing address 192.168.178.227/24 Apr 03 13:48:09 sibermusic dhcpcd[798]: wlan0: soliciting an IPv6 router Apr 03 13:48:10 sibermusic wireless.js[525]: trying... Apr 03 13:48:10 sibermusic sudo[832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:10 sibermusic sudo[832]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:10 sibermusic sudo[832]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:11 sibermusic wireless.js[525]: trying... Apr 03 13:48:11 sibermusic sudo[835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:11 sibermusic sudo[835]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:11 sibermusic sudo[835]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:11 sibermusic wpa_supplicant[786]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 03 13:48:12 sibermusic wireless.js[525]: trying... Apr 03 13:48:12 sibermusic sudo[838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:12 sibermusic sudo[838]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:12 sibermusic sudo[838]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:13 sibermusic wireless.js[525]: trying... Apr 03 13:48:13 sibermusic sudo[841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:13 sibermusic sudo[841]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:13 sibermusic sudo[841]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:14 sibermusic wireless.js[525]: trying... Apr 03 13:48:14 sibermusic sudo[844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:14 sibermusic sudo[844]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:14 sibermusic sudo[844]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:14 sibermusic dhcpcd[798]: wlan0: leased 192.168.178.227 for 604800 seconds Apr 03 13:48:14 sibermusic avahi-daemon[510]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.227. Apr 03 13:48:14 sibermusic dhcpcd[798]: wlan0: adding route to 192.168.178.0/24 Apr 03 13:48:14 sibermusic dhcpcd[798]: wlan0: adding default route via 192.168.178.1 Apr 03 13:48:14 sibermusic avahi-daemon[510]: New relevant interface wlan0.IPv4 for mDNS. Apr 03 13:48:14 sibermusic avahi-daemon[510]: Registering new address record for 192.168.178.227 on wlan0.IPv4. Apr 03 13:48:15 sibermusic wireless.js[525]: trying... Apr 03 13:48:15 sibermusic sudo[868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 03 13:48:15 sibermusic sudo[868]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:15 sibermusic sudo[868]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:15 sibermusic wireless.js[525]: Connected to: ----Ziggy Apr 03 13:48:15 sibermusic wireless.js[525]: ---- Apr 03 13:48:15 sibermusic sudo[871]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 13:48:15 sibermusic sudo[871]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:15 sibermusic sudo[871]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:15 sibermusic wireless.js[525]: ... joined AP, wlan0 IPv4 is 192.168.178.227, ipV6 is undefined Apr 03 13:48:15 sibermusic wireless.js[525]: It's done! AP Apr 03 13:48:15 sibermusic systemd[1]: Started Wireless Services. Apr 03 13:48:15 sibermusic systemd[1]: Started Volumio Backend Module. Apr 03 13:48:15 sibermusic kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 03 13:48:15 sibermusic systemd[1]: Started Volumio Cpu Tweaker. Apr 03 13:48:15 sibermusic volumio-cpu-tweak[877]: Setting RT Priority for mpd Apr 03 13:48:15 sibermusic volumio-cpu-tweak[877]: pid 35's current scheduling policy: SCHED_OTHER Apr 03 13:48:15 sibermusic volumio-cpu-tweak[877]: pid 35's current scheduling priority: 0 Apr 03 13:48:15 sibermusic volumio-cpu-tweak[877]: Setting MPD Affinity Apr 03 13:48:15 sibermusic volumio-cpu-tweak[877]: pid 3's current affinity mask: f Apr 03 13:48:15 sibermusic volumio-cpu-tweak[877]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Apr 03 13:48:15 sibermusic volumio-cpu-tweak[877]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Apr 03 13:48:15 sibermusic systemd[1]: volumio_cpu_tweak.service: Succeeded. Apr 03 13:48:16 sibermusic ntpd[674]: Listen normally on 3 wlan0 192.168.178.227:123 Apr 03 13:48:16 sibermusic ntpd[674]: new interface(s) found: waking up resolver Apr 03 13:48:17 sibermusic volumio[876]: info: ------------------------------------------- Apr 03 13:48:17 sibermusic volumio[876]: info: ----- Volumio3 ---- Apr 03 13:48:17 sibermusic volumio[876]: info: ------------------------------------------- Apr 03 13:48:17 sibermusic volumio[876]: info: ----- System startup ---- Apr 03 13:48:17 sibermusic volumio[876]: info: ------------------------------------------- Apr 03 13:48:17 sibermusic volumio[876]: info: MYVOLUMIO Environment detected Apr 03 13:48:18 sibermusic volumio[876]: info: Plugin folders cleanup Apr 03 13:48:18 sibermusic volumio[876]: info: Scanning into folder /volumio/app/plugins/ Apr 03 13:48:18 sibermusic volumio[876]: info: Scanning category audio_interface Apr 03 13:48:18 sibermusic volumio[876]: info: Scanning category miscellanea Apr 03 13:48:18 sibermusic volumio[876]: info: Scanning category music_service Apr 03 13:48:18 sibermusic volumio[876]: info: Scanning category plugins.json Apr 03 13:48:18 sibermusic volumio[876]: info: Scanning category system_controller Apr 03 13:48:18 sibermusic volumio[876]: info: Scanning category user_interface Apr 03 13:48:18 sibermusic volumio[876]: info: Scanning into folder /data/plugins/ Apr 03 13:48:18 sibermusic volumio[876]: info: Scanning category music_service Apr 03 13:48:18 sibermusic volumio[876]: info: Scanning category system_hardware Apr 03 13:48:18 sibermusic volumio[876]: info: Scanning category user_interface Apr 03 13:48:18 sibermusic volumio[876]: info: Plugin folders cleanup completed Apr 03 13:48:18 sibermusic volumio[876]: info: ------------------------------------------- Apr 03 13:48:18 sibermusic volumio[876]: info: ----- Core plugins startup ---- Apr 03 13:48:18 sibermusic volumio[876]: info: ------------------------------------------- Apr 03 13:48:18 sibermusic volumio[876]: info: Loading plugins from folder /volumio/app/plugins/ Apr 03 13:48:18 sibermusic volumio[876]: info: Adding plugin upnp to MyMusic Plugins Apr 03 13:48:18 sibermusic volumio[876]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 03 13:48:18 sibermusic volumio[876]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 03 13:48:18 sibermusic volumio[876]: info: Loading plugins from folder /data/plugins/ Apr 03 13:48:18 sibermusic volumio[876]: info: Loading plugin "system"... Apr 03 13:48:18 sibermusic volumio[876]: info: Loading plugin "appearance"... Apr 03 13:48:18 sibermusic nmbd[624]: [2024/04/03 13:48:18.664876, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 03 13:48:18 sibermusic systemd[1]: Started Samba NMB Daemon. Apr 03 13:48:18 sibermusic nmbd[624]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 03 13:48:18 sibermusic nmbd[624]: [2024/04/03 13:48:18.686171, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 03 13:48:18 sibermusic nmbd[624]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.227 for name WORKGROUP<1d>. Apr 03 13:48:18 sibermusic nmbd[624]: This response was from IP 192.168.178.59, reporting an IP address of 192.168.178.200. Apr 03 13:48:18 sibermusic nmbd[624]: [2024/04/03 13:48:18.686400, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 03 13:48:18 sibermusic nmbd[624]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.178.227 for name WORKGROUP<1d>. Apr 03 13:48:18 sibermusic nmbd[624]: This response was from IP 192.168.178.200, reporting an IP address of 192.168.178.200. Apr 03 13:48:18 sibermusic systemd[1]: Starting Samba Winbind Daemon... Apr 03 13:48:18 sibermusic volumio-remote-updater[520]: [2024-04-03 13:48:18] [connect] Successful connection Apr 03 13:48:19 sibermusic winbindd[906]: [2024/04/03 13:48:19.007051, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Apr 03 13:48:19 sibermusic winbindd[906]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 03 13:48:19 sibermusic systemd[1]: Started Samba Winbind Daemon. Apr 03 13:48:19 sibermusic nmbd[624]: [2024/04/03 13:48:19.049970, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 03 13:48:19 sibermusic nmbd[624]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.178.227 for name WORKGROUP<1d>. Apr 03 13:48:19 sibermusic nmbd[624]: This response was from IP 192.168.178.200, reporting an IP address of 192.168.178.200. Apr 03 13:48:19 sibermusic nmbd[624]: [2024/04/03 13:48:19.050242, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 03 13:48:19 sibermusic nmbd[624]: query_name_response: Multiple (5) responses received for a query on subnet 192.168.178.227 for name WORKGROUP<1d>. Apr 03 13:48:19 sibermusic nmbd[624]: This response was from IP 192.168.178.200, reporting an IP address of 192.168.178.200. Apr 03 13:48:19 sibermusic winbindd[906]: [2024/04/03 13:48:19.052047, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 03 13:48:19 sibermusic winbindd[906]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 03 13:48:19 sibermusic systemd[1]: Starting Samba SMB Daemon... Apr 03 13:48:20 sibermusic volumio[876]: info: Loading plugin "network"... Apr 03 13:48:20 sibermusic winbindd[906]: [2024/04/03 13:48:20.930555, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Apr 03 13:48:20 sibermusic winbindd[906]: res_names->count = 3, expected 4 Apr 03 13:48:20 sibermusic volumio[876]: info: Refreshing Cached IP Addresses Apr 03 13:48:20 sibermusic smbd[911]: [2024/04/03 13:48:20.952195, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 03 13:48:20 sibermusic systemd[1]: Started Samba SMB Daemon. Apr 03 13:48:20 sibermusic smbd[911]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 03 13:48:20 sibermusic sudo[919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 03 13:48:20 sibermusic sudo[919]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:20 sibermusic volumio[876]: info: Loading plugin "services"... Apr 03 13:48:20 sibermusic volumio[876]: info: Loading plugin "alsa_controller"... Apr 03 13:48:20 sibermusic sudo[919]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:21 sibermusic sudo[923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 13:48:21 sibermusic sudo[923]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:21 sibermusic sudo[925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 03 13:48:21 sibermusic sudo[925]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:21 sibermusic sudo[923]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:21 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 13:48:21 sibermusic volumio[876]: info: Loading plugin "wizard"... Apr 03 13:48:21 sibermusic volumio[876]: info: Loading plugin "networkfs"... Apr 03 13:48:21 sibermusic volumio[876]: info: Starting Udev Watcher for removable devices Apr 03 13:48:21 sibermusic sudo[933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.185/USB /mnt/NAS/USB Apr 03 13:48:21 sibermusic sudo[933]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:48:21 sibermusic volumio[876]: info: Ignoring mount for partition: boot Apr 03 13:48:21 sibermusic volumio[876]: info: Ignoring mount for partition: volumio Apr 03 13:48:21 sibermusic volumio[876]: info: Ignoring mount for partition: volumio_data Apr 03 13:48:21 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 03 13:48:21 sibermusic volumio[876]: info: Loading plugin "volumio_command_line_client"... Apr 03 13:48:21 sibermusic volumio[876]: info: Loading plugin "upnp"... Apr 03 13:48:21 sibermusic volumio[876]: info: [1712144901210] Starting Upmpd Daemon Apr 03 13:48:21 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 03 13:48:21 sibermusic volumio[876]: info: Loading plugin "my_music"... Apr 03 13:48:21 sibermusic volumio[876]: info: Loading plugin "mpd"... Apr 03 13:48:21 sibermusic kernel: Key type cifs.spnego registered Apr 03 13:48:21 sibermusic kernel: Key type cifs.idmap registered Apr 03 13:48:21 sibermusic kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Apr 03 13:48:21 sibermusic kernel: CIFS: Attempting to mount \\192.168.178.185\USB Apr 03 13:48:21 sibermusic volumio[876]: info: Loading plugin "upnp_browser"... Apr 03 13:48:21 sibermusic volumio[876]: info: Loading plugin "alarm-clock"... Apr 03 13:48:21 sibermusic sudo[933]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:21 sibermusic volumio[876]: info: Plugin airplay_emulation is not enabled Apr 03 13:48:21 sibermusic volumio[876]: info: Loading plugin "last_100"... Apr 03 13:48:22 sibermusic volumio[876]: info: Loading plugin "webradio"... Apr 03 13:48:22 sibermusic volumio[876]: info: Loading plugin "i2s_dacs"... Apr 03 13:48:22 sibermusic volumio[876]: info: I2S DAC not set, start Auto-detection Apr 03 13:48:22 sibermusic volumio[876]: info: Loading plugin "volumiodiscovery"... Apr 03 13:48:22 sibermusic volumio[876]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 03 13:48:22 sibermusic node[876]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 03 13:48:22 sibermusic volumio[876]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 03 13:48:22 sibermusic node[876]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 03 13:48:22 sibermusic volumio[876]: *** WARNING *** For more information see Apr 03 13:48:22 sibermusic node[876]: *** WARNING *** For more information see Apr 03 13:48:22 sibermusic volumio[876]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 03 13:48:22 sibermusic node[876]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 03 13:48:22 sibermusic volumio[876]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 03 13:48:22 sibermusic node[876]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 03 13:48:22 sibermusic volumio[876]: *** WARNING *** For more information see Apr 03 13:48:22 sibermusic node[876]: *** WARNING *** For more information see Apr 03 13:48:22 sibermusic volumio[876]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 03 13:48:22 sibermusic volumio[876]: info: Discovery: Started advertising with name: sibermusic Apr 03 13:48:22 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 03 13:48:22 sibermusic volumio[876]: info: Loading plugin "bandcamp"... Apr 03 13:48:23 sibermusic volumio[876]: info: Loading plugin "spop"... Apr 03 13:48:24 sibermusic systemd[1]: systemd-fsckd.service: Succeeded. Apr 03 13:48:24 sibermusic sudo[925]: pam_unix(sudo:session): session closed for user root Apr 03 13:48:24 sibermusic volumio[876]: info: Loading plugin "ytmusic"... Apr 03 13:48:25 sibermusic sh[417]: timed out Apr 03 13:48:25 sibermusic dhcpcd[454]: timed out Apr 03 13:48:25 sibermusic sh[417]: dhcpcd exited Apr 03 13:48:25 sibermusic dhcpcd[454]: dhcpcd exited Apr 03 13:48:25 sibermusic sh[417]: ifup: failed to bring up eth0 Apr 03 13:48:25 sibermusic systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:48:25 sibermusic systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Apr 03 13:48:26 sibermusic sudo[966]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/date -s Sun, 07 Apr 2024 19:52:39 GMT#015 Apr 03 13:48:26 sibermusic sudo[966]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:52:39 sibermusic bash[537]: Sun Apr 7 21:52:39 CEST 2024 Apr 07 21:52:39 sibermusic sudo[966]: pam_unix(sudo:session): session closed for user root Apr 07 21:52:39 sibermusic systemd[1]: Starting Daily man-db regeneration... Apr 07 21:52:39 sibermusic systemd[1]: Starting Daily apt download activities... Apr 07 21:52:39 sibermusic systemd[1]: setdatetime.service: Succeeded. Apr 07 21:52:39 sibermusic systemd[1]: Started Set local time using time server. Apr 07 21:52:39 sibermusic systemd[1]: Reached target Multi-User System. Apr 07 21:52:39 sibermusic systemd[1]: Reached target Graphical Interface. Apr 07 21:52:39 sibermusic systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 07 21:52:39 sibermusic systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 07 21:52:39 sibermusic systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 07 21:52:41 sibermusic volumio[876]: info: Loading plugin "now_playing"... Apr 07 21:52:41 sibermusic systemd[1]: systemd-hostnamed.service: Succeeded. Apr 07 21:52:41 sibermusic systemd[1]: man-db.service: Succeeded. Apr 07 21:52:41 sibermusic systemd[1]: Started Daily man-db regeneration. Apr 07 21:52:42 sibermusic systemd[1]: apt-daily.service: Succeeded. Apr 07 21:52:42 sibermusic systemd[1]: Started Daily apt download activities. Apr 07 21:52:42 sibermusic systemd[1]: Starting Daily apt upgrade and clean activities... Apr 07 21:52:42 sibermusic volumio[876]: info: Loading plugin "outputs"... Apr 07 21:52:42 sibermusic volumio[876]: info: Loading plugin "albumart"... Apr 07 21:52:42 sibermusic volumio[876]: info: Plugin example_plugin is not enabled Apr 07 21:52:42 sibermusic volumio[876]: info: Loading plugin "inputs"... Apr 07 21:52:42 sibermusic volumio[876]: info: Loading plugin "updater_comm"... Apr 07 21:52:43 sibermusic volumio[876]: info: Plugin mpdemulation is not enabled Apr 07 21:52:43 sibermusic volumio[876]: info: Loading plugin "rest_api"... Apr 07 21:52:43 sibermusic volumio[876]: info: Loading plugin "websocket"... Apr 07 21:52:43 sibermusic volumio[876]: info: Loading plugin "ir_controller"... Apr 07 21:52:43 sibermusic systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 07 21:52:43 sibermusic systemd[1]: Started Daily apt upgrade and clean activities. Apr 07 21:52:43 sibermusic systemd[1]: Startup finished in 12.328s (kernel) + 43.246s (userspace) = 55.574s. Apr 07 21:52:43 sibermusic volumio[876]: Forking 3 albumart workers Apr 07 21:52:43 sibermusic volumio[876]: info: Applying required configuration parameters for plugin ir_controller Apr 07 21:52:43 sibermusic volumio[876]: info: Loading plugin "music_services_shield"... Apr 07 21:52:44 sibermusic volumio[876]: info: Applying required configuration parameters for plugin music_services_shield Apr 07 21:52:44 sibermusic volumio[876]: info: Loading plugin "touch_display"... Apr 07 21:52:44 sibermusic volumio[876]: Starting albumart workers Apr 07 21:52:44 sibermusic volumio[876]: Starting albumart workers Apr 07 21:52:44 sibermusic volumio[876]: Starting albumart workers Apr 07 21:52:44 sibermusic volumio[876]: info: Applying required configuration parameters for plugin touch_display Apr 07 21:52:44 sibermusic volumio[876]: info: Loading i18n strings for locale en Apr 07 21:52:44 sibermusic volumio[876]: Updating browse sources language Apr 07 21:52:44 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::initPlayerControls Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 07 21:52:45 sibermusic volumio[876]: Express server listening on port 3000 Apr 07 21:52:45 sibermusic volumio[876]: [Metrics] WebUI: 15s 716.24ms Apr 07 21:52:45 sibermusic volumio[876]: info: CoreStateMachine::resetVolumioState Apr 07 21:52:45 sibermusic volumio[876]: info: CoreStateMachine::getcurrentVolume Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::volumioRetrievevolume Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:52:45 sibermusic sudo[1129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 07 21:52:45 sibermusic sudo[1129]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:52:45 sibermusic sudo[1129]: pam_unix(sudo:session): session closed for user root Apr 07 21:52:45 sibermusic sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 07 21:52:45 sibermusic sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:52:45 sibermusic sudo[1132]: pam_unix(sudo:session): session closed for user root Apr 07 21:52:45 sibermusic volumio[876]: verbose: New Socket.io Connection to 192.168.178.227:3000 from 192.168.178.185 UA: node-XMLHttpRequest Total Clients: 1 Apr 07 21:52:45 sibermusic volumio[876]: verbose: New Socket.io Connection to 192.168.178.227:3000 from 192.168.178.185 UA: node-XMLHttpRequest Total Clients: 2 Apr 07 21:52:45 sibermusic volumio[876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Apr 07 21:52:45 sibermusic volumio[876]: info: VolumeController:: Volume=73 Mute =false Apr 07 21:52:45 sibermusic volumio[876]: info: CoreStateMachine::pushState Apr 07 21:52:45 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::volumioPushState Apr 07 21:52:45 sibermusic volumio[876]: info: CoreStateMachine::updateTrackBlock Apr 07 21:52:45 sibermusic volumio[876]: info: CorePlayQueue::getTrackBlock Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::volumioRetrievevolume Apr 07 21:52:45 sibermusic volumio[876]: info: Reloading queue from file Apr 07 21:52:45 sibermusic volumio[876]: info: Setting Device type: Raspberry PI Apr 07 21:52:45 sibermusic volumio[876]: info: CoreStateMachine::setRepeat false single undefined Apr 07 21:52:45 sibermusic volumio[876]: info: CoreStateMachine::pushState Apr 07 21:52:45 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::volumioPushState Apr 07 21:52:45 sibermusic volumio[876]: info: CoreStateMachine::setRandom false Apr 07 21:52:45 sibermusic volumio[876]: info: CoreStateMachine::pushState Apr 07 21:52:45 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::volumioPushState Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: A device disappeared from network Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: A device disappeared from network Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Apr 07 21:52:45 sibermusic sudo[1144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 07 21:52:45 sibermusic sudo[1144]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:52:45 sibermusic volumio[876]: info: VolumeController:: Volume=73 Mute =false Apr 07 21:52:45 sibermusic volumio[876]: info: CoreStateMachine::pushState Apr 07 21:52:45 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::volumioPushState Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: adding 411a939b-97a5-4cdf-b005-bdba7cc60c5a Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: Found device sibermusic Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:52:45 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:52:45 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:45 sibermusic systemd[1]: Started UPnP Renderer front-end to MPD. Apr 07 21:52:45 sibermusic sudo[1144]: pam_unix(sudo:session): session closed for user root Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: this is already registered, 411a939b-97a5-4cdf-b005-bdba7cc60c5a Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: Found device sibermusic Apr 07 21:52:45 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:52:45 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: adding bead4742-cfbb-4ddb-b635-1868495b0e00 Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: Found device siberup Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: Connecting to remote: 192.168.178.185 Apr 07 21:52:45 sibermusic volumio[876]: info: Upmpdcli Daemon Started Apr 07 21:52:45 sibermusic volumio[876]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: this is already registered, bead4742-cfbb-4ddb-b635-1868495b0e00 Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: Found device siberup Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: Connecting to remote: 192.168.178.185 Apr 07 21:52:45 sibermusic volumio[876]: info: Discovery: Connected to remote: 192.168.178.185 Apr 07 21:52:46 sibermusic volumio-remote-updater[520]: [2024-04-07 21:52:46] [connect] Successful connection Apr 07 21:52:46 sibermusic volumio-remote-updater[520]: [2024-04-07 21:52:46] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1712519566 101 Apr 07 21:52:46 sibermusic volumio[876]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 4 Apr 07 21:52:46 sibermusic sudo[1150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 07 21:52:46 sibermusic sudo[1150]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:52:46 sibermusic sudo[1150]: pam_unix(sudo:session): session closed for user root Apr 07 21:52:46 sibermusic sudo[1153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 07 21:52:46 sibermusic sudo[1153]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:52:46 sibermusic sudo[1153]: pam_unix(sudo:session): session closed for user root Apr 07 21:52:46 sibermusic volumio[876]: verbose: New Socket.io Connection to 192.168.178.227 from 192.168.178.129 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/122.0.0.0 Mobile Safari/537.36 Total Clients: 5 Apr 07 21:52:46 sibermusic nmbd[624]: [2024/04/07 21:52:46.955885, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 07 21:52:46 sibermusic nmbd[624]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.227 for name WORKGROUP<1d>. Apr 07 21:52:46 sibermusic nmbd[624]: This response was from IP 192.168.178.59, reporting an IP address of 192.168.178.200. Apr 07 21:52:46 sibermusic nmbd[624]: [2024/04/07 21:52:46.956563, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 07 21:52:46 sibermusic nmbd[624]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.178.227 for name WORKGROUP<1d>. Apr 07 21:52:46 sibermusic nmbd[624]: This response was from IP 192.168.178.200, reporting an IP address of 192.168.178.200. Apr 07 21:52:46 sibermusic nmbd[624]: [2024/04/07 21:52:46.990022, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 07 21:52:46 sibermusic nmbd[624]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.178.227 for name WORKGROUP<1d>. Apr 07 21:52:46 sibermusic nmbd[624]: This response was from IP 192.168.178.200, reporting an IP address of 192.168.178.200. Apr 07 21:52:46 sibermusic nmbd[624]: [2024/04/07 21:52:46.990331, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 07 21:52:46 sibermusic nmbd[624]: query_name_response: Multiple (5) responses received for a query on subnet 192.168.178.227 for name WORKGROUP<1d>. Apr 07 21:52:46 sibermusic nmbd[624]: This response was from IP 192.168.178.59, reporting an IP address of 192.168.178.200. Apr 07 21:52:46 sibermusic nmbd[624]: [2024/04/07 21:52:46.990632, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 07 21:52:46 sibermusic nmbd[624]: query_name_response: Multiple (6) responses received for a query on subnet 192.168.178.227 for name WORKGROUP<1d>. Apr 07 21:52:46 sibermusic nmbd[624]: This response was from IP 192.168.178.200, reporting an IP address of 192.168.178.200. Apr 07 21:52:47 sibermusic sudo[1157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 07 21:52:47 sibermusic sudo[1157]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:52:47 sibermusic sudo[1157]: pam_unix(sudo:session): session closed for user root Apr 07 21:52:47 sibermusic sudo[1160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 07 21:52:47 sibermusic sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:52:47 sibermusic sudo[1160]: pam_unix(sudo:session): session closed for user root Apr 07 21:52:47 sibermusic volumio[876]: verbose: New Socket.io Connection to 192.168.178.227 from 192.168.178.129 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/122.0.0.0 Mobile Safari/537.36 Total Clients: 6 Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetVisibleSources Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:52:48 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetQueue Apr 07 21:52:48 sibermusic volumio[876]: info: CoreStateMachine::getQueue Apr 07 21:52:48 sibermusic volumio[876]: info: CorePlayQueue::getQueue Apr 07 21:52:48 sibermusic volumio[876]: info: Listing playlists Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 07 21:52:48 sibermusic volumio[876]: info: Received Get System Info Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 21:52:48 sibermusic volumio[876]: info: Discovery: Getting this device information Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:52:48 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:52:48 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 07 21:52:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 07 21:52:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 07 21:52:49 sibermusic volumio[876]: info: Received Get System Info Apr 07 21:52:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 21:52:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 21:52:49 sibermusic volumio[876]: info: Discovery: Getting this device information Apr 07 21:52:49 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:52:49 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 21:52:49 sibermusic volumio[876]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 07 21:52:50 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 07 21:52:51 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 07 21:52:51 sibermusic volumio[876]: info: Received Get System Info Apr 07 21:52:51 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 21:52:51 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 21:52:51 sibermusic volumio[876]: info: Discovery: Getting this device information Apr 07 21:52:51 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:52:51 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:52:51 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 21:52:51 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 07 21:52:55 sibermusic volumio[876]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 07 21:53:03 sibermusic volumio[876]: verbose: New Socket.io Connection to 192.168.178.227 from 192.168.178.129 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/122.0.0.0 Mobile Safari/537.36 Total Clients: 7 Apr 07 21:53:04 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:53:04 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:53:04 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetQueue Apr 07 21:53:04 sibermusic volumio[876]: info: CoreStateMachine::getQueue Apr 07 21:53:04 sibermusic volumio[876]: info: CorePlayQueue::getQueue Apr 07 21:53:04 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Apr 07 21:53:04 sibermusic volumio[876]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Apr 07 21:53:04 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Apr 07 21:53:04 sibermusic volumio[876]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Apr 07 21:53:04 sibermusic volumio[876]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Apr 07 21:53:04 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Apr 07 21:53:05 sibermusic volumio[876]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 07 21:53:06 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 07 21:53:06 sibermusic volumio[876]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 07 21:53:06 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 07 21:53:06 sibermusic volumio[876]: info: Received Get System Version Apr 07 21:53:06 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 07 21:53:06 sibermusic volumio[876]: info: Received Get System Info Apr 07 21:53:06 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 21:53:06 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 21:53:06 sibermusic volumio[876]: info: Discovery: Getting this device information Apr 07 21:53:06 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:53:06 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:53:06 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 21:53:14 sibermusic volumio[876]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion Apr 07 21:53:14 sibermusic volumio[876]: info: Preparing to generate the ALSA configuration file Apr 07 21:53:14 sibermusic volumio[876]: info: Asound.conf file written Apr 07 21:53:14 sibermusic sudo[1198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 07 21:53:14 sibermusic sudo[1198]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:14 sibermusic sudo[1198]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:14 sibermusic volumio[876]: info: Output device has changed, restarting MPD Apr 07 21:53:14 sibermusic sudo[1203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 07 21:53:14 sibermusic sudo[1203]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:14 sibermusic volumio[876]: info: ___________ START PLUGINS ___________ Apr 07 21:53:14 sibermusic sudo[1203]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:14 sibermusic volumio[876]: info: ControllerMpd::onStart: Initializing MPD Apr 07 21:53:14 sibermusic volumio[876]: info: Creating MPD Configuration file Apr 07 21:53:14 sibermusic sudo[1206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 07 21:53:14 sibermusic sudo[1206]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:14 sibermusic systemd[1]: musicservicesshield.service: Succeeded. Apr 07 21:53:14 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 07 21:53:14 sibermusic systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Apr 07 21:53:14 sibermusic volumio[876]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 07 21:53:14 sibermusic systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Apr 07 21:53:14 sibermusic volumio[876]: info: [1712519594919] CoreMusicLibrary::Adding element Media Servers Apr 07 21:53:14 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 21:53:14 sibermusic sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 07 21:53:14 sibermusic sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 07 21:53:15 sibermusic volumio[876]: info: [1712519594936] CoreMusicLibrary::Adding element Last_100 Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 07 21:53:15 sibermusic volumio[876]: info: [1712519594938] CoreMusicLibrary::Adding element Webradio Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 07 21:53:15 sibermusic volumio[876]: info: [1712519594952] CoreMusicLibrary::Adding element Bandcamp Discover Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 21:53:15 sibermusic volumio[876]: Cannot find translation for source Bandcamp Discover Apr 07 21:53:15 sibermusic volumio[876]: info: Creating Spotify config file Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 07 21:53:15 sibermusic volumio[876]: info: [1712519595014] CoreMusicLibrary::Adding element YouTube Music Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 21:53:15 sibermusic volumio[876]: Cannot find translation for source Bandcamp Discover Apr 07 21:53:15 sibermusic volumio[876]: Cannot find translation for source YouTube Music Apr 07 21:53:14 sibermusic sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 07 21:53:14 sibermusic sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:14 sibermusic sudo[1210]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:15 sibermusic systemd[1]: Listening on mpd.socket. Apr 07 21:53:15 sibermusic systemd[1]: Starting Music Player Daemon... Apr 07 21:53:15 sibermusic volumio[876]: info: [now-playing] ConfigUpdater: config is up to date. Apr 07 21:53:15 sibermusic volumio[876]: info: Loading i18n strings for locale en Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 07 21:53:15 sibermusic systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 07 21:53:15 sibermusic systemd[1]: mpd.service: Succeeded. Apr 07 21:53:15 sibermusic systemd[1]: Stopped Music Player Daemon. Apr 07 21:53:15 sibermusic systemd[1]: Starting Music Player Daemon... Apr 07 21:53:15 sibermusic volumio[876]: info: Loading i18n strings for locale en Apr 07 21:53:15 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 07 21:53:15 sibermusic volumio[876]: info: Volumio Calling Home Apr 07 21:53:15 sibermusic sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Apr 07 21:53:15 sibermusic sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:15 sibermusic sudo[1255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc Apr 07 21:53:15 sibermusic sudo[1257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Apr 07 21:53:15 sibermusic sudo[1255]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:15 sibermusic sudo[1257]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:15 sibermusic sudo[1255]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:15 sibermusic sudo[1266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 07 21:53:15 sibermusic sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:15 sibermusic sudo[1267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Apr 07 21:53:15 sibermusic sudo[1267]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:15 sibermusic volumio[876]: info: [now-playing] Fetching API key... Apr 07 21:53:15 sibermusic sudo[1257]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:15 sibermusic systemd[1]: Reloading. Apr 07 21:53:15 sibermusic volumio[876]: info: [now-playing] App is listening on port 4004. Apr 07 21:53:15 sibermusic volumio[876]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Apr 07 21:53:15 sibermusic volumio[876]: info: touch_display: Backlight interface detected. Apr 07 21:53:15 sibermusic volumio[876]: info: touch_display: systemctl stop getty@tty1.service succeeded. Apr 07 21:53:15 sibermusic volumio[876]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Apr 07 21:53:15 sibermusic volumio[876]: info: MPD Permissions set Apr 07 21:53:15 sibermusic volumio[876]: info: Volumio called home Apr 07 21:53:15 sibermusic volumio[876]: info: Spotify config file written Apr 07 21:53:16 sibermusic sudo[1290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 07 21:53:16 sibermusic sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:16 sibermusic volumio[876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic sudo[1243]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:16 sibermusic systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:16 sibermusic volumio[876]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 07 21:53:16 sibermusic volumio[876]: SPOTIFY: BQD_LuZxQpLB1KsPzMq_prA0I_ISh9ixscbP_yD1MHxHSDUNUNMlwPNbukVl_ixFFlNjYX7w1uOPHWxnkF_dlZshV-bSflGjUbJ99ArFOSc0yNuycijqKh1XxbWg0xFnU9YX_U0dQvaKqJp16EL4It3OV6dqg1EJSCAXdxm0-lPY8o15AUwuSk1AbquNca9loAeUWU0I-_nBsUYmps9SRnmiApRWv4S2oH_S2aISY8qyShqFOBuiSv-MQUQRbCsxYp7L1WGCwCI Apr 07 21:53:16 sibermusic volumio[876]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 07 21:53:16 sibermusic volumio[876]: info: New Spotify access token = BQD_LuZxQpLB1KsPzMq_prA0I_ISh9ixscbP_yD1MHxHSDUNUNMlwPNbukVl_ixFFlNjYX7w1uOPHWxnkF_dlZshV-bSflGjUbJ99ArFOSc0yNuycijqKh1XxbWg0xFnU9YX_U0dQvaKqJp16EL4It3OV6dqg1EJSCAXdxm0-lPY8o15AUwuSk1AbquNca9loAeUWU0I-_nBsUYmps9SRnmiApRWv4S2oH_S2aISY8qyShqFOBuiSv-MQUQRbCsxYp7L1WGCwCI Apr 07 21:53:16 sibermusic volumio[876]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 07 21:53:16 sibermusic volumio[876]: info: touch_display: Raspberry Pi Foundation touch screen detected. Apr 07 21:53:16 sibermusic sudo[1307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Apr 07 21:53:16 sibermusic sudo[1307]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:16 sibermusic sudo[1307]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:16 sibermusic sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/rpi_backlight/brightness Apr 07 21:53:16 sibermusic sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:16 sibermusic volumio[876]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Apr 07 21:53:16 sibermusic sudo[1313]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:16 sibermusic sudo[1312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh Apr 07 21:53:16 sibermusic sudo[1312]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:16 sibermusic volumio[876]: info: touch_display: File permissions for backlight brightness control set. Apr 07 21:53:16 sibermusic ntpd[674]: Soliciting pool server 194.104.0.153 Apr 07 21:53:16 sibermusic sudo[1266]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:16 sibermusic volumio[876]: info: ir_controller: LIRC correctly updated. Apr 07 21:53:16 sibermusic volumio[876]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver! Apr 07 21:53:16 sibermusic systemd[1]: Reloading. Apr 07 21:53:16 sibermusic volumio[876]: info: touch_display: systemctl daemon-reload succeeded. Apr 07 21:53:17 sibermusic volumio[876]: (node:876) UnhandledPromiseRejectionWarning: Error: Could not obtain API key Apr 07 21:53:17 sibermusic volumio[876]: at doGet (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:124:19) Apr 07 21:53:17 sibermusic volumio[876]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 07 21:53:17 sibermusic volumio[876]: (Use `node --trace-warnings ...` to show where the warning was created) Apr 07 21:53:17 sibermusic volumio[876]: (node:876) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 3) Apr 07 21:53:17 sibermusic volumio[876]: (node:876) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Apr 07 21:53:17 sibermusic sudo[1334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 07 21:53:17 sibermusic sudo[1334]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:17 sibermusic volumio[876]: info: ir_controller: Raspberry Pi revision code: c03112 Apr 07 21:53:17 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:53:17 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:53:17 sibermusic volumio[876]: SPOTIFY: User informations: {"display_name":"sibermusic","external_urls":{"spotify":"https://open.spotify.com/user/31oqpqhlnukeslyt3pinp75emawe"},"href":"https://api.spotify.com/v1/users/31oqpqhlnukeslyt3pinp75emawe","id":"31oqpqhlnukeslyt3pinp75emawe","images":[{"url":"https://i.scdn.co/image/ab67757000003b8268686fe646192cee39d908f9","height":64,"width":64},{"url":"https://i.scdn.co/image/ab6775700000ee8568686fe646192cee39d908f9","height":300,"width":300}],"type":"user","uri":"spotify:user:31oqpqhlnukeslyt3pinp75emawe","followers":{"href":null,"total":0},"country":"NL","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"gee.siber@gmail.com"} Apr 07 21:53:17 sibermusic volumio[876]: info: Spotify Successfully logged in Apr 07 21:53:17 sibermusic volumio[876]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 07 21:53:17 sibermusic volumio[876]: info: [1712519597205] CoreMusicLibrary::Adding element Spotify Apr 07 21:53:17 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 21:53:17 sibermusic volumio[876]: Cannot find translation for source Bandcamp Discover Apr 07 21:53:17 sibermusic volumio[876]: Cannot find translation for source YouTube Music Apr 07 21:53:17 sibermusic volumio[876]: Cannot find translation for source Spotify Apr 07 21:53:17 sibermusic mpd[1217]: Apr 07 21:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 07 21:53:17 sibermusic systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 07 21:53:17 sibermusic sudo[1350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r -1 Apr 07 21:53:17 sibermusic sudo[1350]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:17 sibermusic sudo[1350]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:17 sibermusic ntpd[674]: Soliciting pool server 185.51.192.62 Apr 07 21:53:17 sibermusic sudo[1360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=25 gpio_pull=up Apr 07 21:53:17 sibermusic kernel: Registered IR keymap rc-rc6-mce Apr 07 21:53:17 sibermusic kernel: IR RC6 protocol handler initialized Apr 07 21:53:17 sibermusic volumio[876]: info: ir_controller: Overlay gpio-ir gpio_pin=25 gpio_pull=up loaded. Apr 07 21:53:17 sibermusic sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:17 sibermusic sudo[1360]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:17 sibermusic sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Apr 07 21:53:17 sibermusic sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:17 sibermusic kernel: rc rc0: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0 Apr 07 21:53:17 sibermusic kernel: rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter Apr 07 21:53:17 sibermusic kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0/input1 Apr 07 21:53:17 sibermusic systemd[1]: Started Music Player Daemon. Apr 07 21:53:17 sibermusic sudo[1267]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:17 sibermusic volumio[876]: info: touch_display: systemctl disable getty@tty1.service succeeded. Apr 07 21:53:17 sibermusic sudo[1206]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:17 sibermusic sudo[1212]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:17 sibermusic kernel: rc rc0: two consecutive events of type space Apr 07 21:53:17 sibermusic volumio[876]: error: MPD error: The expression evaluated to a falsy value: Apr 07 21:53:17 sibermusic volumio[876]: assert.ok(self.idling) Apr 07 21:53:17 sibermusic volumio[876]: error: The expression evaluated to a falsy value: Apr 07 21:53:17 sibermusic volumio[876]: assert.ok(self.idling) Apr 07 21:53:17 sibermusic volumio[876]: info: MPD running with PID1217 Apr 07 21:53:17 sibermusic volumio[876]: ,establishing connection Apr 07 21:53:17 sibermusic volumio[876]: error: updateQueue error: null Apr 07 21:53:17 sibermusic volumio[876]: error: updateQueue error: null Apr 07 21:53:17 sibermusic systemd[1]: Starting lircd(8) initialization helper tool... Apr 07 21:53:17 sibermusic systemd[1]: Started Volumio Kiosk. Apr 07 21:53:17 sibermusic sudo[1334]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:17 sibermusic systemd[1]: Started go-librespot Daemon. Apr 07 21:53:17 sibermusic systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 07 21:53:17 sibermusic go-librespot[1393]: Librespot-go daemon starting... Apr 07 21:53:17 sibermusic sudo[1290]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:17 sibermusic volumio[876]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Apr 07 21:53:17 sibermusic volumio[876]: info: touch_display: Volumio Kiosk started. Apr 07 21:53:17 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:53:17 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:53:18 sibermusic volumio[876]: info: Completed starting Core Plugins Apr 07 21:53:18 sibermusic volumio[876]: info: ------------------------------------------- Apr 07 21:53:18 sibermusic volumio[876]: info: ----- MyVolumio plugins startup ---- Apr 07 21:53:18 sibermusic volumio[876]: info: ------------------------------------------- Apr 07 21:53:18 sibermusic volumio[876]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 07 21:53:18 sibermusic sudo[1405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Apr 07 21:53:18 sibermusic sudo[1405]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:18 sibermusic systemd-udevd[1338]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 07 21:53:18 sibermusic systemd-logind[508]: Watching system buttons on /dev/input/event1 (gpio_ir_recv) Apr 07 21:53:18 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:53:18 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:53:18 sibermusic volumio[876]: info: touch_display: X display number found: Apr 07 21:53:18 sibermusic volumio[876]: info: touch_display: X display number found: 0 Apr 07 21:53:18 sibermusic volumio[876]: info: touch_display: X display number found: 0 Apr 07 21:53:18 sibermusic ntpd[674]: Soliciting pool server 5.255.124.190 Apr 07 21:53:18 sibermusic ntpd[674]: Soliciting pool server 185.224.145.68 Apr 07 21:53:18 sibermusic startx[1392]: X.Org X Server 1.20.4 Apr 07 21:53:18 sibermusic startx[1392]: X Protocol Version 11, Revision 0 Apr 07 21:53:18 sibermusic startx[1392]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Apr 07 21:53:18 sibermusic startx[1392]: Current Operating System: Linux sibermusic 6.1.69-v7l+ #1710 SMP Thu Dec 21 13:17:38 GMT 2023 armv7l Apr 07 21:53:18 sibermusic startx[1392]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:6C:7A:FC vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 Apr 07 21:53:18 sibermusic startx[1392]: Build Date: 04 April 2023 07:50:56AM Apr 07 21:53:18 sibermusic startx[1392]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Apr 07 21:53:18 sibermusic startx[1392]: Current version of pixman: 0.36.0 Apr 07 21:53:18 sibermusic startx[1392]: Before reporting problems, check http://wiki.x.org Apr 07 21:53:18 sibermusic startx[1392]: to make sure that you have the latest version. Apr 07 21:53:18 sibermusic startx[1392]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 07 21:53:18 sibermusic startx[1392]: (++) from command line, (!!) notice, (II) informational, Apr 07 21:53:18 sibermusic startx[1392]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 07 21:53:18 sibermusic startx[1392]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Apr 7 21:53:18 2024 Apr 07 21:53:18 sibermusic volumio[1395]: cset: --> shielding system active with Apr 07 21:53:18 sibermusic startx[1392]: (==) Using config directory: "/etc/X11/xorg.conf.d" Apr 07 21:53:18 sibermusic startx[1392]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 07 21:53:18 sibermusic volumio[1395]: cset: "system" cpuset of CPUSPEC(2-3) with 117 tasks running Apr 07 21:53:18 sibermusic volumio[1395]: cset: "user" cpuset of CPUSPEC(0-1) with 3 tasks running Apr 07 21:53:18 sibermusic volumio[876]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 07 21:53:18 sibermusic go-librespot[1393]: time="2024-04-07T21:53:18+02:00" level=info msg="generated new device id: 275695f1ca962f22b5716efb7922951a61f0205a" Apr 07 21:53:18 sibermusic go-librespot[1393]: time="2024-04-07T21:53:18+02:00" level=debug msg="stored credentials found for 31oqpqhlnukeslyt3pinp75emawe" Apr 07 21:53:18 sibermusic systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 07 21:53:18 sibermusic volumio[876]: info: touch_display: X display number found: 0 Apr 07 21:53:18 sibermusic systemd[1]: Reloading. Apr 07 21:53:18 sibermusic lircd-setup[1387]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Apr 07 21:53:18 sibermusic lircd-setup[1387]: parser = configparser.SafeConfigParser() Apr 07 21:53:19 sibermusic go-librespot[1393]: time="2024-04-07T21:53:19+02:00" level=debug msg="obtained new client token: AADQ6c7NSG8mc6SGZHKKAhMrx20Nu03n9oGQAxSGAfL2BaoYhE1dcIyREDcvDUqRo+7aPJ6uhUuqLhzeHOzT0UbX4kQCoqLWNuedgSAoLT2H/K9lyNGtu315lUyZxbpUPqenlRhnhy/SPgFrCmDq77QhF1A8FVUuVgoJqEw/dLdVaKWjm+X7M4KS+tiTOPkDSnN8brMSe/oUiwgWVdbHXI19udMBHtrSZvtcAcdhE5JmNRXQE6uBqs4g5/pnu7c=" Apr 07 21:53:19 sibermusic systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 07 21:53:19 sibermusic go-librespot[1393]: time="2024-04-07T21:53:19+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 07 21:53:19 sibermusic ntpd[674]: Soliciting pool server 94.198.159.11 Apr 07 21:53:19 sibermusic ntpd[674]: Soliciting pool server 185.51.192.63 Apr 07 21:53:19 sibermusic go-librespot[1393]: time="2024-04-07T21:53:19+02:00" level=debug msg="completed keyexchange" Apr 07 21:53:19 sibermusic ntpd[674]: Soliciting pool server 193.148.248.179 Apr 07 21:53:19 sibermusic sudo[1312]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:19 sibermusic systemd[1]: lircd-setup.service: Succeeded. Apr 07 21:53:19 sibermusic systemd[1]: Started lircd(8) initialization helper tool. Apr 07 21:53:19 sibermusic volumio[876]: info: succeeded Apr 07 21:53:19 sibermusic systemd[1]: Starting Flexible IR remote input/output application support... Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="completed challenge" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="authenticated as 31oqpqhlnukeslyt3pinp75emawe" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="authenticated as 31oqpqhlnukeslyt3pinp75emawe" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="dealer connection opened" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="received connection id: YTFmNDA4ZmUtZjI5YS00M2YyLTkzNTAtNzhiYTdiNGU3MzM0K2RlYWxlcit0Y3A6Ly9nZXc0LWRlYWxlci1hLXQ0ODUuZ2V3NC5zcG90aWZ5Lm5ldDo1NzAwK0Q3MzZFODRERjhBNzExOEU3NzVGRkRBQUU1OEIzMEUxODM4OEIwRUNBQUJFREJEQzExMkUzNUI1MkFFMUYxNTc=" Apr 07 21:53:20 sibermusic go-librespot[1393]: time="2024-04-07T21:53:20+02:00" level=debug msg="put connect state because NEW_DEVICE" Apr 07 21:53:20 sibermusic volumio[876]: info: go-librespot daemon successfully initialized Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Info: lircd: Opening log, level: Info Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Version: lircd 0.10.1 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: System info: Linux sibermusic 6.1.69-v7l+ #1710 SMP Thu Dec 21 13:17:38 GMT 2023 armv7l GNU/Linux Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Info: Initial device: /dev/lirc0 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: 'lirc' written to protocols file /sys/class/rc/rc0/protocols Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Info: Initial device: /dev/lirc0 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Info: [lirc] protocol is enabled Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: driver: default Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: output: /var/run/lirc/lircd Apr 07 21:53:21 sibermusic lircd[1533]: lircd-0.10.1[1533]: Info: lircd: Opening log, level: Info Apr 07 21:53:21 sibermusic lircd[1533]: lircd-0.10.1[1533]: Notice: Using systemd fd Apr 07 21:53:21 sibermusic lircd[1533]: lircd-0.10.1[1533]: Warning: Running as root Apr 07 21:53:21 sibermusic lircd[1533]: lircd-0.10.1[1533]: Info: Using remote: odroid. Apr 07 21:53:21 sibermusic lircd[1533]: lircd-0.10.1[1533]: Notice: lircd(default) ready, using /var/run/lirc/lircd Apr 07 21:53:21 sibermusic systemd[1]: Started Flexible IR remote input/output application support. Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: nodaemon: 1 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: logfile: syslog Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: immediate-init: 0 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: permission: 666 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: driver-options: Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: listen: 0 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: connect: (null) Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: userelease: 0 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: effective_user: (null) Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: release_suffix: _EVUP Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: allow_simulate: 0 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: repeat_max: 600 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: configfile: /etc/lirc/lircd.conf Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Options: dynamic_codes: (null) Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Current driver: default Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Driver API version: 3 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Driver version: 0.10.0 Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Info: lircd: Opening log, level: Info Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: Using systemd fd Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Warning: Running as root Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Info: Using remote: odroid. Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: lircd(default) ready, using /var/run/lirc/lircd Apr 07 21:53:21 sibermusic sudo[1375]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:21 sibermusic sudo[1405]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:21 sibermusic volumio[876]: info: ir_controller: systemctl restart lircd.service succeeded. Apr 07 21:53:21 sibermusic volumio[876]: info: ir_controller: systemctl restart lircd.service succeeded. Apr 07 21:53:21 sibermusic sudo[1610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service Apr 07 21:53:21 sibermusic sudo[1610]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:21 sibermusic sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service Apr 07 21:53:21 sibermusic sudo[1611]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:21 sibermusic systemd[1]: Started Handle events from IR remotes decoded by lircd(8). Apr 07 21:53:21 sibermusic sudo[1610]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:21 sibermusic volumio[876]: info: ir_controller: systemctl restart irexec.service succeeded. Apr 07 21:53:21 sibermusic lircd[1533]: lircd-0.10.1[1533]: Notice: accepted new client on /var/run/lirc/lircd Apr 07 21:53:21 sibermusic lircd[1533]: lircd-0.10.1[1533]: Info: [lirc] protocol is enabled Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: accepted new client on /var/run/lirc/lircd Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Info: [lirc] protocol is enabled Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Info: removed client Apr 07 21:53:21 sibermusic lircd[1533]: lircd-0.10.1[1533]: Info: removed client Apr 07 21:53:21 sibermusic systemd[1]: Stopping Handle events from IR remotes decoded by lircd(8)... Apr 07 21:53:21 sibermusic systemd[1]: irexec.service: Main process exited, code=killed, status=15/TERM Apr 07 21:53:21 sibermusic systemd[1]: irexec.service: Succeeded. Apr 07 21:53:21 sibermusic systemd[1]: Stopped Handle events from IR remotes decoded by lircd(8). Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Notice: accepted new client on /var/run/lirc/lircd Apr 07 21:53:21 sibermusic lircd[1533]: lircd-0.10.1[1533]: Notice: accepted new client on /var/run/lirc/lircd Apr 07 21:53:21 sibermusic lircd[1533]: lircd-0.10.1[1533]: Info: [lirc] protocol is enabled Apr 07 21:53:21 sibermusic lircd-0.10.1[1533]: Info: [lirc] protocol is enabled Apr 07 21:53:21 sibermusic systemd[1]: Started Handle events from IR remotes decoded by lircd(8). Apr 07 21:53:21 sibermusic sudo[1611]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:21 sibermusic volumio[876]: info: ir_controller: systemctl restart irexec.service succeeded. Apr 07 21:53:21 sibermusic startx[1392]: [1B blob data] Apr 07 21:53:22 sibermusic startx[1392]: waiting for X server to begin accepting connections . Apr 07 21:53:22 sibermusic volumio[876]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 07 21:53:22 sibermusic volumio[876]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 07 21:53:24 sibermusic volumio[876]: info: Initializing connection to go-librespot Websocket Apr 07 21:53:24 sibermusic go-librespot[1393]: time="2024-04-07T21:53:24+02:00" level=debug msg="new websocket client" Apr 07 21:53:24 sibermusic volumio[876]: info: Connection to go-librespot Websocket established Apr 07 21:53:25 sibermusic volumio[1146]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 07 21:53:25 sibermusic ntpd[674]: receive: Unexpected origin timestamp 0xe9bd7835.78c4cce7 does not match aorg 0000000000.00000000 from server@5.255.124.190 xmt 0xe9bd7835.a9f6a5d2 Apr 07 21:53:25 sibermusic ntpd[674]: receive: Unexpected origin timestamp 0xe9bd7835.78ca6889 does not match aorg 0000000000.00000000 from server@194.104.0.153 xmt 0xe9bd7835.ab5f93ee Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 07 21:53:26 sibermusic volumio[876]: info: Adding plugin bluetooth to MyMusic Plugins Apr 07 21:53:26 sibermusic volumio[876]: info: Adding plugin multiroom to MyMusic Plugins Apr 07 21:53:26 sibermusic volumio[876]: info: Adding plugin metavolumio to MyMusic Plugins Apr 07 21:53:26 sibermusic volumio[876]: info: Adding plugin cd_controller to MyMusic Plugins Apr 07 21:53:26 sibermusic volumio[876]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 07 21:53:26 sibermusic volumio[876]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 07 21:53:26 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 07 21:53:29 sibermusic volumio[876]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 07 21:53:29 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 07 21:53:29 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:29 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:29 sibermusic volumio[876]: info: Starting MyVolumio Remote Streaming Endpoints Apr 07 21:53:29 sibermusic volumio[876]: info: MyVolumio login type: Token Apr 07 21:53:29 sibermusic volumio[876]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 07 21:53:29 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 07 21:53:30 sibermusic volumio[876]: info: Starting Streaming Service Transparent Proxy Apr 07 21:53:30 sibermusic volumio[876]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 07 21:53:30 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 07 21:53:30 sibermusic volumio[876]: info: Streaming services startup Apr 07 21:53:30 sibermusic volumio[876]: info: Starting Streaming Daemon Apr 07 21:53:30 sibermusic sudo[1772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 07 21:53:30 sibermusic sudo[1772]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:30 sibermusic volumio[876]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 07 21:53:31 sibermusic sudo[1772]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:31 sibermusic volumio[876]: info: Getting Spotify volume Apr 07 21:53:31 sibermusic volumio[876]: error: Cannot start Volumio Streaming Daemon Apr 07 21:53:31 sibermusic volumio[876]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 07 21:53:31 sibermusic volumio[876]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 07 21:53:31 sibermusic volumio[876]: info: Spotify volume: 100 Apr 07 21:53:31 sibermusic volumio[876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 07 21:53:31 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:53:31 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:53:31 sibermusic volumio[876]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Apr 07 21:53:31 sibermusic volumio[876]: SPOTIFY: SPOTIFY VOLUME 100 Apr 07 21:53:31 sibermusic volumio[876]: SPOTIFY: VOLUMIO VOLUME 73 Apr 07 21:53:31 sibermusic volumio[876]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 07 21:53:31 sibermusic volumio[876]: info: Setting Spotify Volume from Volumio: 73 Apr 07 21:53:31 sibermusic volumio[876]: error: MyVolumio Custom Token format not valid, refreshing it Apr 07 21:53:31 sibermusic volumio[876]: info: MyVolumio login type: Token Apr 07 21:53:32 sibermusic volumio[876]: STREAMING PROXY: Starting server on port 3245 Apr 07 21:53:32 sibermusic volumio[876]: Node JS runtime: 14 Apr 07 21:53:32 sibermusic volumio[876]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 07 21:53:32 sibermusic volumio[876]: SPOTIFY: SETTING SPOTIFY VOLUME 73 Apr 07 21:53:32 sibermusic volumio[876]: info: Sending Spotify command with payload to local API: /player/volume Apr 07 21:53:32 sibermusic go-librespot[1393]: time="2024-04-07T21:53:32+02:00" level=debug msg="update volume to 47840/65535" Apr 07 21:53:32 sibermusic go-librespot[1393]: time="2024-04-07T21:53:32+02:00" level=debug msg="put connect state because VOLUME_CHANGED" Apr 07 21:53:32 sibermusic go-librespot[1393]: time="2024-04-07T21:53:32+02:00" level=trace msg="emitting websocket event: volume" Apr 07 21:53:32 sibermusic volumio[876]: SPOTIFY: received: {"type":"volume","data":{"value":73,"max":100}} Apr 07 21:53:32 sibermusic volumio[876]: SPOTIFY: RECEIVED SPOTIFY VOLUME 73 Apr 07 21:53:35 sibermusic volumio[876]: info: MyVolumio token set successfully Apr 07 21:53:35 sibermusic volumio[876]: info: MYVOLUMIO: Adding device Apr 07 21:53:35 sibermusic volumio[876]: info: MYVOLUMIO: Evaluating Server Apr 07 21:53:36 sibermusic volumio[876]: info: MyVolumio Plan changed: premium Apr 07 21:53:36 sibermusic volumio[876]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Apr 07 21:53:36 sibermusic volumio[876]: info: Removing browser output: myVolumio user plan is not superstar Apr 07 21:53:36 sibermusic volumio[876]: info: Removing audio output: Apr 07 21:53:36 sibermusic volumio[876]: info: MYVOLUMIO: Adding device Apr 07 21:53:36 sibermusic volumio[876]: info: MYVOLUMIO: Evaluating Server Apr 07 21:53:36 sibermusic volumio[876]: info: Remote config written successfully Apr 07 21:53:36 sibermusic volumio[876]: info: Starting Tunnel 1 Apr 07 21:53:36 sibermusic volumio[876]: info: Starting Tunnel Connection Checker Apr 07 21:53:36 sibermusic volumio[876]: info: Completed starting MyVolumio Plugin Apr 07 21:53:37 sibermusic volumio[876]: info: MYVolumio Device enabled Apr 07 21:53:37 sibermusic volumio[876]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Apr 07 21:53:37 sibermusic volumio[876]: info: MyVolumio status changed Apr 07 21:53:37 sibermusic volumio[876]: info: Streaming services startup Apr 07 21:53:37 sibermusic volumio[876]: info: Starting Streaming Daemon Apr 07 21:53:37 sibermusic volumio[876]: info: Setting Geolocation for MyVolumio to eu3 Apr 07 21:53:37 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:37 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:37 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:37 sibermusic sudo[1885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 07 21:53:37 sibermusic sudo[1885]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:37 sibermusic sudo[1885]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:37 sibermusic volumio[876]: error: Cannot start Volumio Streaming Daemon Apr 07 21:53:37 sibermusic volumio[876]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 07 21:53:37 sibermusic volumio[876]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 07 21:53:37 sibermusic volumio[876]: info: Setting Geolocation for MyVolumio to eu2 Apr 07 21:53:37 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:37 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:37 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:37 sibermusic volumio[876]: info: Successfully Added MyVolumio device Apr 07 21:53:38 sibermusic volumio[876]: info: Successfully Added MyVolumio device Apr 07 21:53:38 sibermusic volumio[876]: info: Updating MyVolumio device info Apr 07 21:53:38 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:38 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:38 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:38 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 07 21:53:38 sibermusic volumio[876]: error: [MyVolumio PluginManager] Cache data is invalid! Apr 07 21:53:38 sibermusic volumio[876]: info: Updating MyVolumio device info Apr 07 21:53:38 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:38 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:38 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:38 sibermusic volumio[876]: info: Successfully Updated MyVolumio device Apr 07 21:53:38 sibermusic volumio[876]: info: Successfully Updated MyVolumio device Apr 07 21:53:38 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Apr 07 21:53:38 sibermusic volumio[876]: info: [1712519618997] Starting BluetoothController Apr 07 21:53:39 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Apr 07 21:53:40 sibermusic volumio[876]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Apr 07 21:53:40 sibermusic sudo[1902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Apr 07 21:53:40 sibermusic sudo[1902]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:40 sibermusic sudo[1902]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:40 sibermusic volumio[876]: info: MRS: MultiRoom plugin initialized Apr 07 21:53:40 sibermusic volumio[876]: info: MRS: STOPPING SNAPCLIENT Apr 07 21:53:40 sibermusic volumio[876]: info: MRS: Snap server stop Apr 07 21:53:41 sibermusic volumio[876]: info: MRS: STOPPING volumioStreaming Apr 07 21:53:41 sibermusic sudo[1918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Apr 07 21:53:41 sibermusic sudo[1918]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:41 sibermusic sudo[1924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Apr 07 21:53:41 sibermusic sudo[1924]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:41 sibermusic sudo[1922]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Apr 07 21:53:41 sibermusic sudo[1922]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:41 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Apr 07 21:53:41 sibermusic sudo[1924]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:41 sibermusic sudo[1918]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:41 sibermusic sudo[1927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Apr 07 21:53:41 sibermusic sudo[1927]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:41 sibermusic sudo[1927]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:41 sibermusic sudo[1922]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:41 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Apr 07 21:53:41 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Apr 07 21:53:41 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Apr 07 21:53:41 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Apr 07 21:53:41 sibermusic volumio[876]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Apr 07 21:53:41 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Apr 07 21:53:41 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Apr 07 21:53:41 sibermusic volumio[876]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Apr 07 21:53:41 sibermusic volumio[876]: info: Preparing to generate the ALSA configuration file Apr 07 21:53:41 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 07 21:53:41 sibermusic volumio[876]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 07 21:53:41 sibermusic volumio[876]: info: Reading ALSA contributions from plugins. Apr 07 21:53:41 sibermusic volumio[876]: info: MRS: Removed streaming files Apr 07 21:53:41 sibermusic volumio[876]: info: MRS: volumioStreaming STOPPED Apr 07 21:53:41 sibermusic volumio[876]: info: MRS: SNAPSERVER STOPPED Apr 07 21:53:41 sibermusic volumio[876]: info: MRS: SNAPCLIENT STOPPED Apr 07 21:53:41 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 21:53:41 sibermusic volumio[876]: info: Discovery: Getting this device information Apr 07 21:53:41 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:53:41 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:53:41 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 21:53:43 sibermusic volumio[1146]: ......................................................................................................................................................................................++++ Apr 07 21:53:44 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 07 21:53:44 sibermusic volumio[876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Apr 07 21:53:44 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:53:44 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:53:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 07 21:53:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 07 21:53:45 sibermusic volumio-remote-updater[520]: No test mode Apr 07 21:53:45 sibermusic volumio-remote-updater[520]: No alpha test mode Apr 07 21:53:45 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 07 21:53:46 sibermusic volumio[876]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 07 21:53:46 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 07 21:53:46 sibermusic volumio[876]: info: Asound.conf file written Apr 07 21:53:46 sibermusic sudo[1942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 07 21:53:46 sibermusic sudo[1942]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:47 sibermusic volumio[1146]: ................................................++++ Apr 07 21:53:47 sibermusic volumio[1146]: e is 65537 (0x010001) Apr 07 21:53:47 sibermusic volumio[1146]: writing RSA key Apr 07 21:53:48 sibermusic sudo[1942]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:48 sibermusic volumio[876]: info: Output device has changed, restarting MPD Apr 07 21:53:48 sibermusic volumio[876]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic sudo[1963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 07 21:53:48 sibermusic sudo[1963]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 07 21:53:48 sibermusic sudo[1965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 07 21:53:48 sibermusic sudo[1963]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:48 sibermusic sudo[1965]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Apr 07 21:53:48 sibermusic volumio[876]: info: MRS: Pushing multiroomSync output for this device Apr 07 21:53:48 sibermusic volumio[876]: info: MRS: Pushing multiroomSync output Apr 07 21:53:48 sibermusic volumio[876]: info: Adding audio output: Apr 07 21:53:48 sibermusic systemd[1]: musicservicesshield.service: Succeeded. Apr 07 21:53:48 sibermusic systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Apr 07 21:53:48 sibermusic systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Apr 07 21:53:48 sibermusic systemd[1]: Stopping Music Player Daemon... Apr 07 21:53:48 sibermusic volumio[876]: info: Adding audio output: Apr 07 21:53:48 sibermusic systemd[1]: mpd.service: Succeeded. Apr 07 21:53:48 sibermusic sudo[1970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name sibermusic Apr 07 21:53:48 sibermusic systemd[1]: Stopped Music Player Daemon. Apr 07 21:53:48 sibermusic volumio[876]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic sudo[1970]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:48 sibermusic systemd[1]: Starting Music Player Daemon... Apr 07 21:53:48 sibermusic sudo[1970]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Apr 07 21:53:48 sibermusic volumio[876]: info: Adding METAVOLUMIO REST API Endpoints Apr 07 21:53:48 sibermusic volumio[876]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 07 21:53:48 sibermusic volumio[876]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Apr 07 21:53:48 sibermusic volumio[876]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Apr 07 21:53:48 sibermusic volumio[876]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Apr 07 21:53:48 sibermusic volumio[876]: info: Adding Manifest REST API Endpoints Apr 07 21:53:48 sibermusic volumio[876]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Apr 07 21:53:48 sibermusic volumio[876]: info: Adding inputs REST Endpoints Apr 07 21:53:48 sibermusic volumio[876]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Apr 07 21:53:48 sibermusic volumio[876]: info: Scanning Audio Inputs Apr 07 21:53:48 sibermusic volumio[876]: info: Checking against Known Cards name Apr 07 21:53:48 sibermusic volumio[876]: info: Adding Server instance for streaming Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Apr 07 21:53:48 sibermusic volumio[876]: error: Hi Res Audio Failed Login: Missing Login Data Apr 07 21:53:48 sibermusic volumio[876]: info: Adding HIGHRESAUDIO REST API Endpoints Apr 07 21:53:48 sibermusic volumio[876]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Apr 07 21:53:48 sibermusic volumio[876]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting Apr 07 21:53:48 sibermusic volumio[876]: info: Stopping AccessToken refresher cron Apr 07 21:53:48 sibermusic volumio[876]: info: AccessToken refresher cron started Apr 07 21:53:48 sibermusic volumio[876]: info: Stopping AccessToken refresher cron for QOBUZ Apr 07 21:53:48 sibermusic volumio[876]: info: AccessToken refresher cron started for QOBUZ Apr 07 21:53:48 sibermusic volumio[876]: info: Adding TIDAL REST API Endpoints Apr 07 21:53:48 sibermusic volumio[876]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Apr 07 21:53:48 sibermusic volumio[876]: info: Adding QOBUZ REST API Endpoints Apr 07 21:53:48 sibermusic volumio[876]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Apr 07 21:53:48 sibermusic volumio[876]: info: Bluetooth name changed to sibermusic Apr 07 21:53:48 sibermusic volumio[876]: info: MPD Permissions set Apr 07 21:53:48 sibermusic sudo[1979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 07 21:53:48 sibermusic sudo[1979]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic volumio[876]: info: BOOT COMPLETED Apr 07 21:53:48 sibermusic volumio[876]: [Metrics] CommandRouter: 78s 660.73ms Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::volumiosetStartupVolume Apr 07 21:53:48 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:48 sibermusic volumio[876]: info: VolumeController:: Setting startup Volume 75 Apr 07 21:53:48 sibermusic volumio[876]: info: VolumeController::SetAlsaVolume75 Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 21:53:49 sibermusic systemd[1]: Started MyVolumio SSH Tunnel. Apr 07 21:53:49 sibermusic sudo[1979]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::Close All Modals sent Apr 07 21:53:49 sibermusic autossh[1988]: port set to 0, monitoring disabled Apr 07 21:53:49 sibermusic autossh[1988]: starting ssh (count 1) Apr 07 21:53:49 sibermusic autossh[1988]: ssh child pid is 1991 Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::Close All Modals sent Apr 07 21:53:49 sibermusic volumio[876]: info: CoreStateMachine::pushState Apr 07 21:53:49 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::volumioPushState Apr 07 21:53:49 sibermusic volumio[876]: info: MRS: Pushing multiroomSync output update for this device Apr 07 21:53:49 sibermusic volumio[876]: info: MRS: Pushing multiroomSync output Apr 07 21:53:49 sibermusic volumio[876]: info: MRS: Adding multiroomSync output Apr 07 21:53:49 sibermusic volumio[876]: info: Adding audio output: Apr 07 21:53:49 sibermusic volumio[876]: info: MRS: Pushing multiroomSync output Apr 07 21:53:49 sibermusic volumio[876]: info: Remote SSH Started Apr 07 21:53:49 sibermusic volumiossh-tunnel[1985]: Warning: Permanently added '[eu2.myvolumio.org]:2222,[185.14.187.123]:2222' (RSA) to the list of known hosts. Apr 07 21:53:49 sibermusic mpd[1973]: Apr 07 21:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 07 21:53:49 sibermusic volumio[876]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Apr 07 21:53:49 sibermusic volumio[876]: SPOTIFY: SPOTIFY VOLUME 73 Apr 07 21:53:49 sibermusic volumio[876]: SPOTIFY: VOLUMIO VOLUME 75 Apr 07 21:53:49 sibermusic volumio[876]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 07 21:53:49 sibermusic volumio[876]: info: Setting Spotify Volume from Volumio: 75 Apr 07 21:53:49 sibermusic volumio[876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 10 Apr 07 21:53:49 sibermusic volumio[876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 11 Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 07 21:53:49 sibermusic systemd[1]: Started Music Player Daemon. Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetBrowseSources Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 07 21:53:49 sibermusic sudo[1965]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:49 sibermusic volumio[876]: info: MRS: Found cast device: LG-WK7-ThinQ-Speaker-f62c623a3eb8addf4dfe8c7a030fdd67 Apr 07 21:53:49 sibermusic volumio[876]: info: Adding audio output: Apr 07 21:53:49 sibermusic systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 07 21:53:49 sibermusic volumio[876]: info: [now-playing] Fetching API key... Apr 07 21:53:49 sibermusic volumio[876]: error: updateQueue error: null Apr 07 21:53:49 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:53:49 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:53:50 sibermusic volumio[876]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Apr 07 21:53:50 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Apr 07 21:53:50 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 07 21:53:50 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 07 21:53:50 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 07 21:53:50 sibermusic volumio[876]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not fetch weather: Could not obtain API key Apr 07 21:53:50 sibermusic volumio[876]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:114:19) Apr 07 21:53:50 sibermusic volumio[876]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 07 21:53:50 sibermusic volumio[876]: at async Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:113:28) Apr 07 21:53:50 sibermusic volumio[876]: (node:876) UnhandledPromiseRejectionWarning: Error: Could not obtain API key Apr 07 21:53:50 sibermusic volumio[876]: at doGet (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:124:19) Apr 07 21:53:50 sibermusic volumio[876]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 07 21:53:50 sibermusic volumio[876]: (node:876) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 6) Apr 07 21:53:50 sibermusic volumio[1996]: cset: --> shielding system active with Apr 07 21:53:50 sibermusic volumio[1996]: cset: "system" cpuset of CPUSPEC(2-3) with 243 tasks running Apr 07 21:53:50 sibermusic volumio[1996]: cset: "user" cpuset of CPUSPEC(0-1) with 3 tasks running Apr 07 21:53:50 sibermusic systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 07 21:53:50 sibermusic volumio[876]: info: Listing playlists Apr 07 21:53:50 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetQueue Apr 07 21:53:50 sibermusic volumio[876]: info: CoreStateMachine::getQueue Apr 07 21:53:50 sibermusic volumio[876]: info: CorePlayQueue::getQueue Apr 07 21:53:50 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetVisibleSources Apr 07 21:53:50 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 21:53:50 sibermusic volumio[876]: info: CoreCommandRouter::volumioGetState Apr 07 21:53:50 sibermusic volumio[876]: info: CorePlayQueue::getTrack 0 Apr 07 21:53:50 sibermusic volumio[876]: SPOTIFY: SETTING SPOTIFY VOLUME 75 Apr 07 21:53:50 sibermusic volumio[876]: info: Sending Spotify command with payload to local API: /player/volume Apr 07 21:53:50 sibermusic go-librespot[1393]: time="2024-04-07T21:53:50+02:00" level=debug msg="update volume to 49151/65535" Apr 07 21:53:51 sibermusic go-librespot[1393]: time="2024-04-07T21:53:51+02:00" level=debug msg="put connect state because VOLUME_CHANGED" Apr 07 21:53:51 sibermusic go-librespot[1393]: time="2024-04-07T21:53:51+02:00" level=trace msg="emitting websocket event: volume" Apr 07 21:53:51 sibermusic volumio[876]: SPOTIFY: received: {"type":"volume","data":{"value":75,"max":100}} Apr 07 21:53:51 sibermusic volumio[876]: SPOTIFY: RECEIVED SPOTIFY VOLUME 75 Apr 07 21:53:51 sibermusic sudo[2021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Apr 07 21:53:51 sibermusic sudo[2021]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:51 sibermusic systemd[1]: Started Volumio Bluetooth Module. Apr 07 21:53:51 sibermusic sudo[2021]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:51 sibermusic volumio[876]: info: Volumio BT Module successfully started Apr 07 21:53:52 sibermusic sudo[2024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Apr 07 21:53:52 sibermusic sudo[2024]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:52 sibermusic volumiobt[2023]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Apr 07 21:53:52 sibermusic sudo[2024]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:53 sibermusic sudo[2027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Apr 07 21:53:53 sibermusic sudo[2027]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:53:53 sibermusic volumiobt[2023]: pulseaudio: no process found Apr 07 21:53:53 sibermusic sudo[2027]: pam_unix(sudo:session): session closed for user root Apr 07 21:53:53 sibermusic dbus-daemon[511]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.27' (uid=1000 pid=2031 comm="/usr/bin/pulseaudio --high-priority=true ") Apr 07 21:53:53 sibermusic systemd[1]: Starting RealtimeKit Scheduling Policy Service... Apr 07 21:53:53 sibermusic volumio[876]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 07 21:53:53 sibermusic dbus-daemon[511]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Apr 07 21:53:53 sibermusic rtkit-daemon[2032]: Successfully called chroot. Apr 07 21:53:53 sibermusic rtkit-daemon[2032]: Successfully dropped privileges. Apr 07 21:53:53 sibermusic systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 07 21:53:53 sibermusic rtkit-daemon[2032]: Successfully limited resources. Apr 07 21:53:53 sibermusic rtkit-daemon[2032]: Running. Apr 07 21:53:53 sibermusic rtkit-daemon[2032]: Watchdog thread running. Apr 07 21:53:53 sibermusic dbus-daemon[511]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.28' (uid=0 pid=2032 comm="/usr/lib/rtkit/rtkit-daemon ") Apr 07 21:53:53 sibermusic rtkit-daemon[2032]: Canary thread running. Apr 07 21:53:53 sibermusic systemd[1]: Starting Authorization Manager... Apr 07 21:53:53 sibermusic volumio[876]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 07 21:53:53 sibermusic polkitd[2035]: started daemon version 0.105 using authority implementation `local' version `0.105' Apr 07 21:53:53 sibermusic dbus-daemon[511]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 07 21:53:53 sibermusic systemd[1]: Started Authorization Manager. Apr 07 21:53:53 sibermusic volumio[876]: info: MRS: Getting audio outputs on start Apr 07 21:53:53 sibermusic volumio[876]: info: MRS: Requesting all other devices output Apr 07 21:53:53 sibermusic pulseaudio[2031]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 07 21:53:53 sibermusic pulseaudio[2031]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 07 21:53:53 sibermusic volumiobt[2023]: Applying permissions Apr 07 21:53:53 sibermusic volumiobt[2023]: Setting BT discoverable and pairable Apr 07 21:53:53 sibermusic pulseaudio[2031]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Apr 07 21:53:53 sibermusic bluetoothd[663]: Endpoint registered: sender=:1.48 path=/MediaEndpoint/A2DPSource Apr 07 21:53:53 sibermusic bluetoothd[663]: Endpoint registered: sender=:1.48 path=/MediaEndpoint/A2DPSink Apr 07 21:53:53 sibermusic kernel: Bluetooth: RFCOMM TTY layer initialized Apr 07 21:53:53 sibermusic kernel: Bluetooth: RFCOMM socket layer initialized Apr 07 21:53:53 sibermusic kernel: Bluetooth: RFCOMM ver 1.11 Apr 07 21:53:53 sibermusic volumiobt[2023]: [CHG] Controller DC:A6:32:6C:7A:FE Class: 0x0008041c Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [55B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [91B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [117B blob data] Apr 07 21:53:53 sibermusic volumiobt[2023]: [bluetooth]# -e power on Apr 07 21:53:53 sibermusic volumiobt[2023]: Invalid command in menu main: -e Apr 07 21:53:53 sibermusic volumiobt[2023]: Apr 07 21:53:53 sibermusic volumiobt[2023]: Use "help" for a list of available commands in a menu. Apr 07 21:53:53 sibermusic volumiobt[2023]: Use "menu " if you want to enter any submenu. Apr 07 21:53:53 sibermusic volumiobt[2023]: Use "back" if you want to return to menu main. Apr 07 21:53:53 sibermusic volumiobt[2023]: [bluetooth]# agent on Apr 07 21:53:53 sibermusic volumiobt[2023]: Agent is already registered Apr 07 21:53:53 sibermusic volumiobt[2023]: [bluetooth]# discoverable on Apr 07 21:53:53 sibermusic volumiobt[2023]: [bluetooth]# pairable on Apr 07 21:53:53 sibermusic volumiobt[2023]: [bluetooth]# agent NoInputNoOutput Apr 07 21:53:53 sibermusic volumiobt[2023]: Agent is already registered Apr 07 21:53:53 sibermusic volumiobt[2023]: [bluetooth]# default-agent Apr 07 21:53:53 sibermusic volumiobt[2023]: [bluetooth]# quit Apr 07 21:53:53 sibermusic volumiobt[2023]: [59B blob data] Apr 07 21:53:54 sibermusic kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 1 Apr 07 21:53:54 sibermusic kernel: xhci_hcd 0000:01:00.0: @000000042a119ca0 00000000 00000000 0e000000 02028001 Apr 07 21:54:25 sibermusic ntpd[674]: Soliciting pool server 195.123.221.21 Apr 07 21:54:25 sibermusic ntpd[674]: Soliciting pool server 185.51.192.63 Apr 07 21:54:25 sibermusic ntpd[674]: Soliciting pool server 154.51.12.220 Apr 07 21:54:26 sibermusic ntpd[674]: Soliciting pool server 86.80.166.233 Apr 07 21:55:09 sibermusic volumio[876]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Apr 07 21:55:09 sibermusic volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Apr 07 21:55:09 sibermusic sudo[2289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig Apr 07 21:55:09 sibermusic sudo[2289]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 21:55:09 sibermusic sudo[2289]: pam_unix(sudo:session): session closed for user root Apr 07 21:55:17 sibermusic sudo[2387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Apr 07 21:55:17 sibermusic sudo[2387]: pam_unix(sudo:session): session opened for user root by (uid=0)