Sat Aug 9 14:37:00 WEST 2025 Description="'connected DAC after rebootin as per recommendation'" # cat /proc/version --------------- Linux version 6.6.62-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #1816 SMP Mon Nov 18 15:33:33 GMT 2024 # 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c" # ifconfig --------------- eth0: flags=4099 mtu 1500 ether 2c:cf:67:64:a9:29 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 560 bytes 65581 (64.0 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 560 bytes 65581 (64.0 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 wlan0: flags=4163 mtu 1500 inet 192.168.1.190 netmask 255.255.255.0 broadcast 192.168.1.255 ether 2c:cf:67:64:a9:2a txqueuelen 1000 (Ethernet) RX packets 1871 bytes 363467 (354.9 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 2323 bytes 1487913 (1.4 MiB) 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:"Vodafone-8E504E" Mode:Managed Frequency:5.5 GHz Access Point: C0:F6:EC:8E:50:58 Bit Rate=433.3 Mb/s Tx-Power=31 dBm Retry short limit:7 RTS thr:off Fragment thr:off Encryption key:off Power Management:off Link Quality=66/70 Signal level=-44 dBm Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:0 Tx excessive retries:0 Invalid misc:0 Missed beacon:0 # aplay -l --------------- **** List of PLAYBACK Hardware Devices **** card 0: b1 [bcm2835 HDMI 1], device 0: bcm2835 HDMI 1 [bcm2835 HDMI 1] Subdevices: 4/4 Subdevice #0: subdevice #0 Subdevice #1: subdevice #1 Subdevice #2: subdevice #2 Subdevice #3: subdevice #3 card 0: b1 [bcm2835 HDMI 1], device 1: bcm2835 HDMI 1 [bcm2835 HDMI 1] Subdevices: 1/1 Subdevice #0: subdevice #0 card 1: Headphones [bcm2835 Headphones], device 0: bcm2835 Headphones [bcm2835 Headphones] Subdevices: 3/4 Subdevice #0: subdevice #0 Subdevice #1: subdevice #1 Subdevice #2: subdevice #2 Subdevice #3: subdevice #3 card 5: Audio [Digital Hifi Audio], device 0: USB Audio [USB Audio] Subdevices: 1/1 Subdevice #0: subdevice #0 card 5: Audio [Digital Hifi Audio], device 1: USB Audio [USB Audio #1] Subdevices: 1/1 Subdevice #0: subdevice #0 # lsusb --------------- Bus 002 Device 002: ID 0bc2:ab26 Seagate RSS LLC Backup Plus Slim Portable Drive 1 TB Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub Bus 001 Device 003: ID 262a:9023 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 |__ Port 2: Dev 2, If 0, Class=Mass Storage, Driver=uas, 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 4: Dev 3, If 0, Class=Human Interface Device, Driver=usbhid, 12M |__ Port 4: Dev 3, If 1, Class=Audio, Driver=snd-usb-audio, 12M |__ Port 4: Dev 3, If 3, Class=Audio, Driver=snd-usb-audio, 12M # lsusb -v --------------- Couldn't open device, some information will be missing Bus 002 Device 002: ID 0bc2:ab26 Seagate RSS LLC Backup Plus Slim Portable Drive 1 TB Device Descriptor: bLength 18 bDescriptorType 1 bcdUSB 3.00 bDeviceClass 0 bDeviceSubClass 0 bDeviceProtocol 0 bMaxPacketSize0 9 idVendor 0x0bc2 Seagate RSS LLC idProduct 0xab26 Backup Plus Slim Portable Drive 1 TB bcdDevice 1.09 iManufacturer 1 iProduct 2 iSerial 3 bNumConfigurations 1 Configuration Descriptor: bLength 9 bDescriptorType 2 wTotalLength 0x0079 bNumInterfaces 1 bConfigurationValue 1 iConfiguration 0 bmAttributes 0x80 (Bus Powered) MaxPower 896mA Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 0 bAlternateSetting 0 bNumEndpoints 2 bInterfaceClass 8 Mass Storage bInterfaceSubClass 6 SCSI bInterfaceProtocol 80 Bulk-Only iInterface 0 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x81 EP 1 IN bmAttributes 2 Transfer Type Bulk Synch Type None Usage Type Data wMaxPacketSize 0x0400 1x 1024 bytes bInterval 0 bMaxBurst 15 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x02 EP 2 OUT bmAttributes 2 Transfer Type Bulk Synch Type None Usage Type Data wMaxPacketSize 0x0400 1x 1024 bytes bInterval 0 bMaxBurst 15 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 0 bAlternateSetting 1 bNumEndpoints 4 bInterfaceClass 8 Mass Storage bInterfaceSubClass 6 SCSI bInterfaceProtocol 98 iInterface 0 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x01 EP 1 OUT bmAttributes 2 Transfer Type Bulk Synch Type None Usage Type Data wMaxPacketSize 0x0400 1x 1024 bytes bInterval 0 bMaxBurst 0 Command pipe (0x01) Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x82 EP 2 IN bmAttributes 2 Transfer Type Bulk Synch Type None Usage Type Data wMaxPacketSize 0x0400 1x 1024 bytes bInterval 0 bMaxBurst 0 MaxStreams 32 Status pipe (0x02) Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x83 EP 3 IN bmAttributes 2 Transfer Type Bulk Synch Type None Usage Type Data wMaxPacketSize 0x0400 1x 1024 bytes bInterval 0 bMaxBurst 15 MaxStreams 32 Data-in pipe (0x03) Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x04 EP 4 OUT bmAttributes 2 Transfer Type Bulk Synch Type None Usage Type Data wMaxPacketSize 0x0400 1x 1024 bytes bInterval Couldn't open device, some information will be missing Couldn't open device, some information will be missing 0 bMaxBurst 7 MaxStreams 32 Data-out pipe (0x04) 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.06 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 262a:9023 Device Descriptor: bLength 18 bDescriptorType 1 bcdUSB 1.10 bDeviceClass 0 bDeviceSubClass 0 bDeviceProtocol 0 bMaxPacketSize0 8 idVendor 0x262a idProduct 0x9023 bcdDevice 0.01 iManufacturer 1 iProduct 2 iSerial 0 bNumConfigurations 1 Configuration Descriptor: bLength 9 bDescriptorType 2 wTotalLength 0x0106 bNumInterfaces 3 bConfigurationValue 1 iConfiguration 0 bmAttributes 0x80 (Bus Powered) MaxPower 500mA Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 0 bAlternateSetting 0 bNumEndpoints 1 bInterfaceClass 3 Human Interface Device bInterfaceSubClass 0 bInterfaceProtocol 0 iInterface 0 HID Device Descriptor: bLength 9 bDescriptorType 33 bcdHID 1.00 bCountryCode 0 Not supported bNumDescriptors 1 bDescriptorType 34 Report wDescriptorLength 92 Report Descriptors: ** UNAVAILABLE ** Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x81 EP 1 IN bmAttributes 3 Transfer Type Interrupt Synch Type None Usage Type Data wMaxPacketSize 0x0013 1x 19 bytes bInterval 32 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 1 bAlternateSetting 0 bNumEndpoints 0 bInterfaceClass 1 Audio bInterfaceSubClass 1 Control Device bInterfaceProtocol 0 iInterface 3 AudioControl Interface Descriptor: bLength 9 bDescriptorType 36 bDescriptorSubtype 1 (HEADER) bcdADC 1.00 wTotalLength 0x0036 bInCollection 1 baInterfaceNr(0) 3 AudioControl Interface Descriptor: bLength 12 bDescriptorType 36 bDescriptorSubtype 2 (INPUT_TERMINAL) bTerminalID 6 wTerminalType 0x0101 USB Streaming bAssocTerminal 0 bNrChannels 2 wChannelConfig 0x0003 Left Front (L) Right Front (R) iChannelNames 0 iTerminal 0 AudioControl Interface Descriptor: bLength 10 bDescriptorType 36 bDescriptorSubtype 6 (FEATURE_UNIT) bUnitID 9 bSourceID 6 bControlSize 1 bmaControls(0) 0x01 Mute Control bmaControls(1) 0x02 Volume Control bmaControls(2) 0x02 Volume Control iFeature 0 AudioControl Interface Descriptor: bLength 9 bDescriptorType 36 bDescriptorSubtype 3 (OUTPUT_TERMINAL) bTerminalID 2 wTerminalType 0x0605 SPDIF interface bAssocTerminal 0 bSourceID 9 iTerminal 0 AudioControl Interface Descriptor: bLength 14 bDescriptorType 36 bDescriptorSubtype 8 (EXTENSION_UNIT) bUnitID 15 wExtensionCode 0x0000 bNrInPins 0 bNrChannels 2 wChannelConfig 0x0003 Left Front (L) Right Front (R) iChannelNames 0 bControlSize 1 iExtension 0 Warning: Junk at end of descriptor (1 bytes): 00 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 3 bAlternateSetting 0 bNumEndpoints 0 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 0 iInterface 0 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 3 bAlternateSetting 1 bNumEndpoints 1 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 0 iInterface 0 AudioStreaming Interface Descriptor: bLength 7 bDescriptorType 36 bDescriptorSubtype 1 (AS_GENERAL) bTerminalLink 6 bDelay 1 frames wFormatTag 0x0001 PCM AudioStreaming Interface Descriptor: bLength 23 bDescriptorType 36 bDescriptorSubtype 2 (FORMAT_TYPE) bFormatType 1 (FORMAT_TYPE_I) bNrChannels 2 bSubframeSize 2 bBitResolution 16 bSamFreqType 5 Discrete tSamFreq[ 0] 96000 tSamFreq[ 1] 88200 tSamFreq[ 2] 48000 tSamFreq[ 3] 44100 tSamFreq[ 4] 32000 Endpoint Descriptor: bLength 9 bDescriptorType 5 bEndpointAddress 0x03 EP 3 OUT bmAttributes 9 Transfer Type Isochronous Synch Type Adaptive Usage Type Data wMaxPacketSize 0x0190 1x 400 bytes bInterval 1 bRefresh 0 bSynchAddress 0 AudioStreaming Endpoint Descriptor: bLength 7 bDescriptorType 37 bDescriptorSubtype 1 (EP_GENERAL) bmAttributes 0x01 Sampling Frequency bLockDelayUnits 0 Undefined wLockDelay 0x0000 Couldn't open device, some information will be missing Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 3 bAlternateSetting 2 bNumEndpoints 1 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 0 iInterface 0 AudioStreaming Interface Descriptor: bLength 7 bDescriptorType 36 bDescriptorSubtype 1 (AS_GENERAL) bTerminalLink 6 bDelay 1 frames wFormatTag 0x0001 PCM AudioStreaming Interface Descriptor: bLength 23 bDescriptorType 36 bDescriptorSubtype 2 (FORMAT_TYPE) bFormatType 1 (FORMAT_TYPE_I) bNrChannels 2 bSubframeSize 3 bBitResolution 24 bSamFreqType 5 Discrete tSamFreq[ 0] 96000 tSamFreq[ 1] 88200 tSamFreq[ 2] 48000 tSamFreq[ 3] 44100 tSamFreq[ 4] 32000 Endpoint Descriptor: bLength 9 bDescriptorType 5 bEndpointAddress 0x03 EP 3 OUT bmAttributes 9 Transfer Type Isochronous Synch Type Adaptive Usage Type Data wMaxPacketSize 0x0258 1x 600 bytes bInterval 1 bRefresh 0 bSynchAddress 0 AudioStreaming Endpoint Descriptor: bLength 7 bDescriptorType 37 bDescriptorSubtype 1 (EP_GENERAL) bmAttributes 0x01 Sampling Frequency bLockDelayUnits 0 Undefined wLockDelay 0x0000 Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 3 bAlternateSetting 3 bNumEndpoints 1 bInterfaceClass 1 Audio bInterfaceSubClass 2 Streaming bInterfaceProtocol 0 iInterface 0 AudioStreaming Interface Descriptor: bLength 7 bDescriptorType 36 bDescriptorSubtype 1 (AS_GENERAL) bTerminalLink 6 bDelay 1 frames wFormatTag 0x2001 IEC1937_AC-3 AudioStreaming Interface Descriptor: bLength 14 bDescriptorType 36 bDescriptorSubtype 2 (FORMAT_TYPE) bFormatType 3 (FORMAT_TYPE_III) bNrChannels 2 bSubframeSize 2 bBitResolution 16 bSamFreqType 2 Discrete tSamFreq[ 0] 48000 tSamFreq[ 1] 44100 Endpoint Descriptor: bLength 9 bDescriptorType 5 bEndpointAddress 0x03 EP 3 OUT bmAttributes 9 Transfer Type Isochronous Synch Type Adaptive Usage Type Data wMaxPacketSize 0x00d0 1x 208 bytes bInterval 1 bRefresh 0 bSynchAddress 0 AudioStreaming Endpoint Descriptor: bLength 7 bDescriptorType 37 bDescriptorSubtype 1 (EP_GENERAL) bmAttributes 0x01 Sampling Frequency bLockDelayUnits 0 Undefined wLockDelay 0x0000 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 iManufactuCouldn't open device, some information will be missing rer 0 iProduct 1 iSerial 0 bNumConfigurations 1 Configuration Descriptor: bLength 9 bDescriptorType 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.06 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 1 14:33 ? 00:00:02 /sbin/init splash nodebug root 2 0 0 14:33 ? 00:00:00 [kthreadd] root 3 2 0 14:33 ? 00:00:00 [pool_workqueue_release] root 4 2 0 14:33 ? 00:00:00 [kworker/R-rcu_g] root 5 2 0 14:33 ? 00:00:00 [kworker/R-rcu_p] root 6 2 0 14:33 ? 00:00:00 [kworker/R-slub_] root 7 2 0 14:33 ? 00:00:00 [kworker/R-netns] root 8 2 0 14:33 ? 00:00:00 [kworker/0:0-device_link_wq] root 9 2 0 14:33 ? 00:00:00 [kworker/0:0H-events_highpri] root 10 2 0 14:33 ? 00:00:00 [kworker/0:1-events] root 11 2 0 14:33 ? 00:00:00 [kworker/u8:0-cfg80211] root 12 2 0 14:33 ? 00:00:00 [kworker/R-mm_pe] root 13 2 0 14:33 ? 00:00:00 [rcu_tasks_rude_kthread] root 14 2 0 14:33 ? 00:00:00 [rcu_tasks_trace_kthread] root 15 2 0 14:33 ? 00:00:00 [ksoftirqd/0] root 16 2 0 14:33 ? 00:00:00 [rcu_sched] root 17 2 0 14:33 ? 00:00:00 [migration/0] root 18 2 0 14:33 ? 00:00:00 [cpuhp/0] root 19 2 0 14:33 ? 00:00:00 [cpuhp/1] root 20 2 0 14:33 ? 00:00:00 [migration/1] root 21 2 0 14:33 ? 00:00:00 [ksoftirqd/1] root 22 2 0 14:33 ? 00:00:00 [kworker/1:0-cgroup_destroy] root 23 2 0 14:33 ? 00:00:00 [kworker/1:0H-events_highpri] root 24 2 0 14:33 ? 00:00:00 [cpuhp/2] root 25 2 0 14:33 ? 00:00:00 [migration/2] root 26 2 0 14:33 ? 00:00:00 [ksoftirqd/2] root 27 2 0 14:33 ? 00:00:00 [kworker/2:0-mm_percpu_wq] root 28 2 0 14:33 ? 00:00:00 [kworker/2:0H-events_highpri] root 29 2 0 14:33 ? 00:00:00 [cpuhp/3] root 30 2 0 14:33 ? 00:00:00 [migration/3] root 31 2 0 14:33 ? 00:00:00 [ksoftirqd/3] root 32 2 0 14:33 ? 00:00:00 [kworker/3:0-cgroup_destroy] root 33 2 0 14:33 ? 00:00:00 [kworker/3:0H-events_highpri] root 34 2 0 14:33 ? 00:00:00 [kworker/u9:0-events_unbound] root 35 2 0 14:33 ? 00:00:00 [kworker/u10:0-loop0] root 36 2 0 14:33 ? 00:00:00 [kworker/u11:0-loop0] root 37 2 0 14:33 ? 00:00:00 [kworker/u12:0-loop0] root 38 2 0 14:33 ? 00:00:00 [kdevtmpfs] root 39 2 0 14:33 ? 00:00:00 [kworker/R-inet_] root 40 2 0 14:33 ? 00:00:00 [kworker/u9:1-events_unbound] root 41 2 0 14:33 ? 00:00:00 [kauditd] root 42 2 0 14:33 ? 00:00:00 [khungtaskd] root 43 2 0 14:33 ? 00:00:00 [oom_reaper] root 44 2 0 14:33 ? 00:00:00 [kworker/R-write] root 45 2 0 14:33 ? 00:00:00 [kcompactd0] root 46 2 0 14:33 ? 00:00:00 [kworker/R-kinte] root 47 2 0 14:33 ? 00:00:00 [kworker/R-kbloc] root 48 2 0 14:33 ? 00:00:00 [kworker/R-blkcg] root 49 2 0 14:33 ? 00:00:00 [kworker/u9:2-loop0] root 50 2 0 14:33 ? 00:00:00 [kworker/u9:3-loop0] root 51 2 0 14:33 ? 00:00:00 [kworker/u9:4-events_unbound] root 52 2 0 14:33 ? 00:00:00 [watchdogd] root 53 2 0 14:33 ? 00:00:00 [kworker/0:1H-kblockd] root 54 2 0 14:33 ? 00:00:00 [kworker/R-rpcio] root 55 2 0 14:33 ? 00:00:00 [kworker/R-xprti] root 56 2 0 14:33 ? 00:00:00 [kworker/2:1-events] root 57 2 0 14:33 ? 00:00:00 [kswapd0] root 58 2 0 14:33 ? 00:00:00 [kworker/R-nfsio] root 59 2 0 14:33 ? 00:00:00 [kworker/R-kthro] root 60 2 0 14:33 ? 00:00:00 [kworker/0:2-rcu_gp] root 61 2 0 14:33 ? 00:00:00 [kworker/0:3-events] root 62 2 0 14:33 ? 00:00:00 [hwrng] root 63 2 0 14:33 ? 00:00:00 [kworker/R-iscsi] root 64 2 0 14:33 ? 00:00:00 [kworker/R-nvme-] root 65 2 0 14:33 ? 00:00:00 [kworker/R-nvme-] root 66 2 0 14:33 ? 00:00:00 [kworker/R-nvme-] root 68 2 0 14:33 ? 00:00:00 [kworker/R-DWC N] root 69 2 0 14:33 ? 00:00:00 [kworker/R-uas] root 70 2 0 14:33 ? 00:00:00 [vchiq-slot/0] root 71 2 0 14:33 ? 00:00:00 [vchiq-recy/0] root 72 2 0 14:33 ? 00:00:00 [vchiq-sync/0] root 73 2 0 14:33 ? 00:00:00 [kworker/u13:0-brcmf_wq/mmc1:0001:1] root 74 2 0 14:33 ? 00:00:00 [kworker/u14:0] root 75 2 0 14:33 ? 00:00:00 [kworker/u15:0] root 76 2 0 14:33 ? 00:00:00 [kworker/u16:0] root 77 2 0 14:33 ? 00:00:00 [kworker/u17:0] root 78 2 0 14:33 ? 00:00:00 [kworker/R-sdhci] root 79 2 0 14:33 ? 00:00:00 [irq/52-mmc0] root 80 2 0 14:33 ? 00:00:00 [kworker/1:1-mm_percpu_wq] root 81 2 0 14:33 ? 00:00:00 [kworker/3:1-mm_percpu_wq] root 82 2 0 14:33 ? 00:00:00 [kworker/u10:1-loop0] root 98 2 0 14:33 ? 00:00:00 [kworker/1:2-events] root 106 2 0 14:33 ? 00:00:00 [kworker/3:1H-kblockd] root 110 2 0 14:33 ? 00:00:00 [kworker/1:1H-kblockd] root 125 2 0 14:33 ? 00:00:00 [kworker/R-mmc_c] root 142 2 0 14:33 ? 00:00:00 [kworker/2:1H-kblockd] root 143 2 0 14:33 ? 00:00:00 [kworker/1:2H-kblockd] root 144 2 0 14:33 ? 00:00:00 [scsi_eh_0] root 145 2 0 14:33 ? 00:00:00 [kworker/R-scsi_] root 151 2 0 14:33 ? 00:00:00 [kworker/u12:1-events_unbound] root 181 2 0 14:33 ? 00:00:00 [kworker/3:2H-kblockd] root 184 2 0 14:33 ? 00:00:00 [kworker/3:2-events] root 186 2 0 14:33 ? 00:00:00 [kworker/u11:1] root 187 2 0 14:33 ? 00:00:00 [kworker/u11:2-loop0] root 214 2 0 14:33 ? 00:00:00 [kworker/2:2-cgroup_destroy] root 216 2 0 14:33 ? 00:00:00 [kworker/u12:2-loop0] root 226 2 0 14:33 ? 00:00:00 [jbd2/mmcblk0p2-8] root 227 2 0 14:33 ? 00:00:00 [kworker/R-ext4-] root 259 2 0 14:33 ? 00:00:00 [kworker/2:2H-kblockd] root 260 2 0 14:33 ? 00:00:00 [kworker/0:2H-kblockd] root 265 2 0 14:33 ? 00:00:00 [kworker/u10:2-events_unbound] root 273 2 0 14:33 ? 00:00:00 [jbd2/mmcblk0p3-8] root 274 2 0 14:33 ? 00:00:00 [kworker/R-ext4-] root 308 2 0 14:33 ? 00:00:00 [kworker/R-mld] root 309 2 0 14:33 ? 00:00:00 [kworker/R-ipv6_] root 339 1 0 14:33 ? 00:00:00 /lib/systemd/systemd-journald root 345 2 0 14:33 ? 00:00:00 [kworker/2:3-events] root 360 1 0 14:33 ? 00:00:00 /lib/systemd/systemd-udevd root 402 2 0 14:33 ? 00:00:00 [vchiq-keep/0] root 404 2 0 14:33 ? 00:00:00 [SMIO] root 464 2 0 14:33 ? 00:00:00 [kworker/R-mmal-] root 465 2 0 14:33 ? 00:00:00 [kworker/R-mmal-] root 467 2 0 14:33 ? 00:00:00 [kworker/R-mmal-] root 468 2 0 14:33 ? 00:00:00 [irq/54-feb10000.codec] root 469 2 0 14:33 ? 00:00:00 [kworker/R-mmal-] root 470 2 0 14:33 ? 00:00:00 [kworker/R-mmal-] root 472 2 0 14:33 ? 00:00:00 [kworker/R-mmal-] root 473 2 0 14:33 ? 00:00:00 [kworker/R-mmal-] root 490 2 0 14:33 ? 00:00:00 [kworker/R-cfg80] root 491 2 0 14:33 ? 00:00:00 [kworker/u13:1-hci0] root 492 2 0 14:33 ? 00:00:00 [kworker/u13:2-hci0] root 496 2 0 14:33 ? 00:00:00 [kworker/R-brcmf] root 497 2 0 14:33 ? 00:00:00 [brcmf_wdog/mmc1:0001:1] root 500 2 0 14:33 ? 00:00:00 [kworker/u11:3-events_unbound] root 501 2 0 14:33 ? 00:00:00 [kworker/u13:3-hci0] root 521 2 0 14:33 ? 00:00:00 [kworker/3:3] root 558 1 0 14:33 ? 00:00:01 /usr/sbin/haveged --Foreground --verbose=1 -w 1024 _rpc 564 1 0 14:33 ? 00:00:00 /sbin/rpcbind -f -w volumio 593 1 0 14:33 ? 00:00:00 /usr/local/bin/volumio-remote-updater nobody 594 1 0 14:33 ? 00:00:00 /usr/sbin/thd --triggers /etc/triggerhappy/triggers.d/ --socket /run/thd.socket --user nobody --deviceglob /dev/input/event* avahi 595 1 0 14:33 ? 00:00:00 avahi-daemon: running [jmjukebox.local] root 596 1 0 14:33 ? 00:00:00 /lib/systemd/systemd-logind root 598 1 0 14:33 ? 00:00:00 /bin/bash /bin/mpd_monitor.sh message+ 599 1 0 14:33 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only root 601 1 0 14:33 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant root 604 1 0 14:33 ? 00:00:00 /bin/bash /bin/volumiologrotate root 609 1 0 14:33 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon avahi 643 595 0 14:33 ? 00:00:00 avahi-daemon: chroot helper root 672 2 0 14:33 ? 00:00:00 [kworker/u12:3-loop0] root 735 1 0 14:33 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 736 1 0 14:33 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap root 738 2 0 14:33 ? 00:00:00 [kworker/u10:3] root 760 1 0 14:33 tty1 00:00:00 /sbin/agetty -o -p -- \u --noclear tty1 linux ntp 763 1 0 14:33 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 root 769 1 0 14:33 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I root 774 1 0 14:33 ? 00:00:00 /usr/sbin/sshd -D root 817 735 0 14:33 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 901 1 0 14:33 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0 root 913 1 0 14:33 ? 00:00:00 /sbin/dhcpcd root 937 2 0 14:33 ? 00:00:00 [kworker/u8:1-netns] volumio 1040 1 8 14:33 ? 00:00:15 /usr/bin/node /volumio/index.js root 1057 1 0 14:34 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group root 1060 1057 0 14:34 ? 00:00:00 winbindd: domain child [JMJUKEBOX] root 1062 1 0 14:34 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 1064 1062 0 14:34 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 1065 1062 0 14:34 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 1066 1057 0 14:34 ? 00:00:00 winbindd: idmap child root 1067 1057 0 14:34 ? 00:00:00 winbindd: domain child [BUILTIN] root 1068 1062 0 14:34 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group volumio 1089 1040 0 14:34 ? 00:00:00 /bin/bash /volumio/app/plugins/system_controller/network/network_monitor.sh root 1120 1 0 14:34 ? 00:00:00 /sbin/mount.ntfs /dev/sda1 /media/JMO_2T -o rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 volumio 1126 1040 0 14:34 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1133 1126 0 14:34 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1134 1126 0 14:34 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1135 1126 0 14:34 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart root 1216 2 0 14:34 ? 00:00:00 [kworker/1:3-events_power_efficient] volumio 1240 1 0 14:34 ? 00:00:00 /bin/sh /bin/start-go-librespot.sh volumio 1244 1240 0 14:34 ? 00:00:00 /usr/bin/go-librespot --config_dir /data/go-librespot/ shairpo+ 1277 1 0 14:34 ? 00:00:00 /usr/bin/shairport-sync --configfile=/tmp/shairport-sync.conf mpd 1279 1 0 14:34 ? 00:00:01 /usr/bin/mpd --no-daemon volumio 1302 1 0 14:34 ? 00:00:01 /usr/bin/python3 /data/plugins/audio_interface/fusiondsp/cgui/main.py volumio 1330 1 0 14:34 ? 00:00:00 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf volumio 1361 1040 0 14:34 ? 00:00:00 /usr/bin/node /myvolumio/plugins/music_service/streaming_services/streamingProxy.js volumio 1519 1040 0 14:34 ? 00:00:00 /data/plugins/audio_interface/fusiondsp/camilladsp -p 9876 -o /tmp/camilladsp.log -l warn /data/configuration/audio_interface/fusiondsp/camilladsp.yml root 1908 604 0 14:36 ? 00:00:00 sleep 60 volumio 1940 1089 0 14:36 ? 00:00:00 sleep 10 root 1944 598 0 14:36 ? 00:00:00 sleep 20 volumio 1945 1040 0 14:36 ? 00:00:00 /bin/sh -c /usr/bin/node /volumio/logsubmit.js 'connected DAC after rebootin as per recommendation' volumio 1946 1945 0 14:36 ? 00:00:00 /usr/bin/node /volumio/logsubmit.js connected DAC after rebootin as per recommendation volumio 1974 1946 0 14:36 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 1975 1974 0 14:36 ? 00:00:00 ps -ef # df -h --------------- Filesystem Size Used Avail Use% Mounted on udev 1.9G 0 1.9G 0% /dev tmpfs 379M 9.0M 370M 3% /run /dev/mmcblk0p2 2.5G 1.2G 1.2G 50% /imgpart /dev/loop0 491M 491M 0 100% /static overlay 55G 575M 51G 2% / tmpfs 1.9G 0 1.9G 0% /dev/shm tmpfs 5.0M 4.0K 5.0M 1% /run/lock tmpfs 1.9G 0 1.9G 0% /sys/fs/cgroup tmpfs 1.9G 80K 1.9G 1% /tmp tmpfs 1.9G 0 1.9G 0% /var/spool/cups tmpfs 20M 28K 20M 1% /var/log tmpfs 1.9G 0 1.9G 0% /var/spool/cups/tmp /dev/mmcblk0p1 91M 82M 9.0M 91% /boot /dev/sda1 1.9T 1.4T 517G 73% /media/JMO_2T # mount --------------- sysfs on /sys type sysfs (rw,nosuid,nodev,noexec,relatime) proc on /proc type proc (rw,relatime) udev on /dev type devtmpfs (rw,nosuid,relatime,size=1890420k,nr_inodes=142395,mode=755) devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000) tmpfs on /run type tmpfs (rw,nosuid,nodev,noexec,relatime,size=387652k,mode=755) /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) securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime) tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev,noexec) 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/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer) cgroup on /sys/fs/cgroup/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpu,cpuacct) cgroup on /sys/fs/cgroup/net_cls,net_prio type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls,net_prio) cgroup on /sys/fs/cgroup/perf_event type cgroup (rw,nosuid,nodev,noexec,relatime,perf_event) cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices) 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/blkio type cgroup (rw,nosuid,nodev,noexec,relatime,blkio) systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=29,pgrp=1,timeout=0,minproto=5,maxproto=5,direct) configfs on /sys/kernel/config type configfs (rw,relatime) mqueue on /dev/mqueue type mqueue (rw,relatime) debugfs on /sys/kernel/debug type debugfs (rw,relatime) sunrpc on /run/rpc_pipefs type rpc_pipefs (rw,relatime) fusectl on /sys/fs/fuse/connections type fusectl (rw,relatime) tmpfs on /tmp type tmpfs (rw,noatime,mode=755) tmpfs on /var/spool/cups 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/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) /dev/sda1 on /media/JMO_2T type fuseblk (rw,noatime,user_id=0,group_id=0,default_permissions,allow_other,blksize=4096) # 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 1330/upmpdcli tcp 0 0 0.0.0.0:445 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:5011 0.0.0.0:* LISTEN 1302/python3 tcp 0 0 0.0.0.0:5000 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:111 0.0.0.0:* LISTEN - tcp 0 0 127.0.0.1:9876 0.0.0.0:* LISTEN 1519/camilladsp tcp 0 0 127.0.0.1:9879 0.0.0.0:* LISTEN 1244/go-librespot 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 1330/upmpdcli tcp 0 0 0.0.0.0:139 0.0.0.0:* LISTEN - tcp 0 0 127.0.0.1:9879 127.0.0.1:42710 ESTABLISHED 1244/go-librespot tcp 0 0 127.0.0.1:42710 127.0.0.1:9879 ESTABLISHED 1040/node tcp 0 0 192.168.1.190:49152 192.168.1.71:40088 TIME_WAIT - tcp 0 0 127.0.0.1:58972 127.0.0.1:3000 ESTABLISHED 1040/node tcp 0 0 127.0.0.1:50048 127.0.0.1:3000 ESTABLISHED 1040/node tcp 0 0 192.168.1.190:49152 192.168.1.71:40126 TIME_WAIT - tcp 0 0 192.168.1.190:49152 192.168.1.71:40128 TIME_WAIT - tcp 0 0 127.0.0.1:33136 127.0.0.1:6600 ESTABLISHED 1040/node tcp 0 0 127.0.0.1:52776 127.0.0.1:3000 ESTABLISHED 1040/node tcp 0 0 127.0.0.1:50104 127.0.0.1:3000 ESTABLISHED 1040/node tcp 0 0 127.0.0.1:50032 127.0.0.1:3000 ESTABLISHED 593/volumio-remote- tcp 0 0 192.168.1.190:48192 34.120.160.131:443 ESTABLISHED 1040/node tcp 0 0 127.0.0.1:48586 127.0.0.1:6599 ESTABLISHED 1330/upmpdcli tcp 0 0 127.0.0.1:48598 127.0.0.1:6599 ESTABLISHED 1330/upmpdcli tcp6 0 0 :::6600 :::* LISTEN - tcp6 0 0 :::6599 :::* LISTEN 1040/node tcp6 0 0 :::3001 :::* LISTEN 1126/node tcp6 0 0 :::3000 :::* LISTEN 1040/node tcp6 0 0 :::3005 :::* LISTEN 1040/node tcp6 0 0 :::445 :::* LISTEN - tcp6 0 0 :::5000 :::* LISTEN - tcp6 0 0 :::111 :::* LISTEN - tcp6 0 0 :::38477 :::* LISTEN 1244/go-librespot tcp6 0 0 :::22 :::* LISTEN - tcp6 0 0 :::3245 :::* LISTEN 1361/node tcp6 0 0 :::139 :::* LISTEN - tcp6 0 0 127.0.0.1:3000 127.0.0.1:50104 ESTABLISHED 1040/node tcp6 0 0 192.168.1.190:3000 192.168.1.81:12176 ESTABLISHED 1040/node tcp6 0 0 192.168.1.190:3000 192.168.1.69:53942 ESTABLISHED 1040/node tcp6 0 0 192.168.1.190:3000 192.168.1.69:37500 TIME_WAIT - tcp6 0 0 127.0.0.1:3000 127.0.0.1:58972 ESTABLISHED 1040/node tcp6 0 0 192.168.1.190:3000 192.168.1.69:53960 ESTABLISHED 1040/node tcp6 0 0 192.168.1.190:3000 192.168.1.69:57904 TIME_WAIT - tcp6 0 0 127.0.0.1:6600 127.0.0.1:33136 ESTABLISHED - tcp6 0 0 192.168.1.190:3000 192.168.1.81:12403 FIN_WAIT2 - tcp6 0 0 192.168.1.190:3000 192.168.1.81:12405 FIN_WAIT2 - tcp6 0 0 127.0.0.1:3000 127.0.0.1:50048 ESTABLISHED 1040/node tcp6 0 0 192.168.1.190:3000 192.168.1.81:12404 FIN_WAIT2 - tcp6 0 0 127.0.0.1:3000 127.0.0.1:50032 ESTABLISHED 1040/node tcp6 0 0 127.0.0.1:6599 127.0.0.1:48586 ESTABLISHED 1040/node tcp6 0 0 192.168.1.190:3000 192.168.1.81:12406 ESTABLISHED 1040/node tcp6 0 0 127.0.0.1:6599 127.0.0.1:48598 ESTABLISHED 1040/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:52776 ESTABLISHED 1040/node # cat /boot/config.txt --------------- ### DO NOT EDIT THIS FILE ### ### APPLY CUSTOM PARAMETERS TO userconfig.txt ### initramfs volumio.initrd gpu_mem=128 gpu_mem_256=32 gpu_mem_512=32 gpu_mem_1024=128 max_usb_current=1 [pi5] usb_max_current_enable=1 [all] include volumioconfig.txt include userconfig.txt # cat /boot/userconfig.txt --------------- # Add your custom config.txt options to this file, which will be preserved during updates # cat /etc/asound.conf --------------- pcm.!default { type empty slave.pcm "volumio" } pcm.volumio { type empty slave.pcm "volumioDsp" } #------ FusionDsp section ------- pcm.volumioDsp { type plug slave { format "S32_LE" channels 2 pcm "fusiondsphook" } } pcm.fusiondsphook { type volumiohook slave.pcm "fusiondspfifo" hw_params_command "echo '%r,%f,%c,%d' >/tmp/fusiondsp_stream_params.log" } pcm.fusiondspfifo { type volumiofifo fifo "/tmp/fusiondspfifo" format_3 "S16_LE" format_4 "S24_LE" format_5 "S32_LE" clear_on_drop "false" } #------ End of FusionDsp section ------ pcm.postDsp { 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 "Headphones" } # cat /var/log/mpd.log --------------- Aug 09 14:29 : zeroconf: No global port, disabling zeroconf Aug 09 14:34 : zeroconf: No global port, disabling zeroconf # cat /tmp/camilladsp.log --------------- # 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: 'FusionDsp', name: 'fusiondsp', category: 'audio_interface', version: '1.0.61', icon: 'fa-sliders fa-rotate-90', isManuallyInstalled: true, enabled: true, active: true }, { prettyName: 'Spotify', name: 'spop', category: 'music_service', version: '4.1.4', icon: 'fa-spotify', isManuallyInstalled: false, enabled: true, active: true } ] ------------------------------------------ # cat /data/configuration/plugins.json --------------- { "music_service": { "airplay_emulation": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "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" } }, "spop": { "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" } }, "fusiondsp": { "enabled": { "type": "boolean", "value": true }, "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" } } }, "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" } } }, "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" } } } } # 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 "12288" ############################################################################### # 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, 460 ms: OK https://www.googleapis.com, 278 ms: OK https://securetoken.googleapis.com, 293 ms: OK https://myvolumio.firebaseio.com, 830 ms: OK https://functions.volumio.cloud, 375 ms: OK https://oauth-performer.dfs.volumio.org, 329 ms: OK https://browsing-performer.dfs.volumio.org, 285 ms: OK http://cddb.volumio.org, 642 ms: OK https://functions.volumio.cloud, 456 ms: OK http://pushupdates.volumio.org, 258 ms: OK http://plugins.volumio.org, 856 ms: OK https://database.volumio.cloud, 808 ms: OK https://radio-directory.firebaseapp.com, 221 ms: OK ---------- REMOTE ENDPOINTS TEST OK, all Endpoints are reachable ---------- # cat /data/updatesHistoryFile --------------- --- Tue Jun 10 2025 14:59:21 GMT+0000 (Coordinated Universal Time) {"systemversion":"3.816","builddate":"Tue 10 Jun 2025 04:52:53 PM CEST","variant":"volumio","hardware":"pi","os":"10"} ------ Sun Aug 03 2025 17:39:55 GMT+0100 (Western European Summer Time) {"systemversion":"3.832","builddate":"Sat 26 Jul 2025 10:25:36 AM CEST","variant":"volumio","hardware":"pi","os":"10"} --- # sudo journalctl -p 7 --------------- -- Logs begin at Thu 2019-02-14 10:11:59 WET, end at Sat 2025-08-09 14:37:03 WEST. -- Feb 14 10:11:59 jmjukebox kernel: Booting Linux on physical CPU 0x0 Feb 14 10:11:59 jmjukebox kernel: Linux version 6.6.62-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #1816 SMP Mon Nov 18 15:33:33 GMT 2024 Feb 14 10:11:59 jmjukebox kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d Feb 14 10:11:59 jmjukebox kernel: CPU: div instructions available: patching division code Feb 14 10:11:59 jmjukebox kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache Feb 14 10:11:59 jmjukebox kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.5 Feb 14 10:11:59 jmjukebox kernel: random: crng init done Feb 14 10:11:59 jmjukebox kernel: Memory policy: Data cache writealloc Feb 14 10:11:59 jmjukebox kernel: Reserved memory: created CMA memory pool at 0x0000000029400000, size 64 MiB Feb 14 10:11:59 jmjukebox kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Feb 14 10:11:59 jmjukebox kernel: OF: reserved mem: 0x0000000029400000..0x000000002d3fffff (65536 KiB) map reusable linux,cma Feb 14 10:11:59 jmjukebox kernel: OF: reserved mem: 0x000000003ef65420..0x000000003ef6561f (0 KiB) nomap non-reusable nvram@1 Feb 14 10:11:59 jmjukebox kernel: OF: reserved mem: 0x000000003ef65660..0x000000003ef65695 (0 KiB) nomap non-reusable nvram@0 Feb 14 10:11:59 jmjukebox kernel: Zone ranges: Feb 14 10:11:59 jmjukebox kernel: DMA [mem 0x0000000000000000-0x000000002fffffff] Feb 14 10:11:59 jmjukebox kernel: Normal empty Feb 14 10:11:59 jmjukebox kernel: HighMem [mem 0x0000000030000000-0x00000000fbffffff] Feb 14 10:11:59 jmjukebox kernel: Movable zone start for each node Feb 14 10:11:59 jmjukebox kernel: Early memory node ranges Feb 14 10:11:59 jmjukebox kernel: node 0: [mem 0x0000000000000000-0x0000000037ffffff] Feb 14 10:11:59 jmjukebox kernel: node 0: [mem 0x0000000040000000-0x00000000fbffffff] Feb 14 10:11:59 jmjukebox kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff] Feb 14 10:11:59 jmjukebox kernel: percpu: Embedded 18 pages/cpu s42004 r8192 d23532 u73728 Feb 14 10:11:59 jmjukebox kernel: pcpu-alloc: s42004 r8192 d23532 u73728 alloc=18*4096 Feb 14 10:11:59 jmjukebox kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Feb 14 10:11:59 jmjukebox kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 numa=fake=2 system_heap.max_order=0 smsc95xx.macaddr=2C:CF:67:64:A9:29 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=UUID=ee200d97-771e-4dc2-bc54-5383b3c7262f imgfile=/volumio_current.sqsh bootpart=UUID=6D56-80AF datapart=UUID=9da5fc58-f342-443d-83b5-60353d527d53 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 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 nodebug use_kmsg=no Feb 14 10:11:59 jmjukebox kernel: cgroup: Disabling memory control group subsystem Feb 14 10:11:59 jmjukebox kernel: Unknown kernel command line parameters "splash nodebug numa_policy=interleave numa=fake=2 imgpart=UUID=ee200d97-771e-4dc2-bc54-5383b3c7262f imgfile=/volumio_current.sqsh bootpart=UUID=6D56-80AF datapart=UUID=9da5fc58-f342-443d-83b5-60353d527d53 uuidconfig=cmdline.txt pcie_aspm=off bootdelay=7 use_kmsg=no", will be passed to user space. Feb 14 10:11:59 jmjukebox kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: Built 1 zonelists, mobility grouping on. Total pages: 997696 Feb 14 10:11:59 jmjukebox kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Feb 14 10:11:59 jmjukebox kernel: software IO TLB: area num 4. Feb 14 10:11:59 jmjukebox kernel: software IO TLB: mapped [mem 0x0000000023090000-0x0000000027090000] (64MB) Feb 14 10:11:59 jmjukebox kernel: Memory: 3780844K/3997696K available (12288K kernel code, 1527K rwdata, 3492K rodata, 2048K init, 628K bss, 151316K reserved, 65536K cma-reserved, 3211264K highmem) Feb 14 10:11:59 jmjukebox kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Feb 14 10:11:59 jmjukebox kernel: ftrace: allocating 38825 entries in 114 pages Feb 14 10:11:59 jmjukebox kernel: ftrace: allocated 114 pages with 4 groups Feb 14 10:11:59 jmjukebox kernel: trace event string verifier disabled Feb 14 10:11:59 jmjukebox kernel: rcu: Hierarchical RCU implementation. Feb 14 10:11:59 jmjukebox kernel: Rude variant of Tasks RCU enabled. Feb 14 10:11:59 jmjukebox kernel: Tracing variant of Tasks RCU enabled. Feb 14 10:11:59 jmjukebox kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. Feb 14 10:11:59 jmjukebox kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Feb 14 10:11:59 jmjukebox kernel: GIC: Using split EOI/Deactivate mode Feb 14 10:11:59 jmjukebox kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Feb 14 10:11:59 jmjukebox kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Feb 14 10:11:59 jmjukebox kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Feb 14 10:11:59 jmjukebox kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Feb 14 10:11:59 jmjukebox kernel: Switching to timer-based delay loop, resolution 18ns Feb 14 10:11:59 jmjukebox kernel: Console: colour dummy device 80x30 Feb 14 10:11:59 jmjukebox kernel: printk: console [tty1] enabled Feb 14 10:11:59 jmjukebox kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000) Feb 14 10:11:59 jmjukebox kernel: CPU: Testing write buffer coherency: ok Feb 14 10:11:59 jmjukebox kernel: CPU0: Spectre BHB: enabling loop workaround for all CPUs Feb 14 10:11:59 jmjukebox kernel: pid_max: default: 32768 minimum: 301 Feb 14 10:11:59 jmjukebox kernel: LSM: initializing lsm=capability,integrity Feb 14 10:11:59 jmjukebox kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Feb 14 10:11:59 jmjukebox kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 14 10:11:59 jmjukebox kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 14 10:11:59 jmjukebox kernel: Setting up static identity map for 0x200000 - 0x20003c Feb 14 10:11:59 jmjukebox kernel: rcu: Hierarchical SRCU implementation. Feb 14 10:11:59 jmjukebox kernel: rcu: Max phase no-delay instances is 1000. Feb 14 10:11:59 jmjukebox kernel: smp: Bringing up secondary CPUs ... Feb 14 10:11:59 jmjukebox kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Feb 14 10:11:59 jmjukebox kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Feb 14 10:11:59 jmjukebox kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Feb 14 10:11:59 jmjukebox kernel: smp: Brought up 1 node, 4 CPUs Feb 14 10:11:59 jmjukebox kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS). Feb 14 10:11:59 jmjukebox kernel: CPU: All CPU(s) started in HYP mode. Feb 14 10:11:59 jmjukebox kernel: CPU: Virtualization extensions available. Feb 14 10:11:59 jmjukebox kernel: devtmpfs: initialized Feb 14 10:11:59 jmjukebox kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0 Feb 14 10:11:59 jmjukebox kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Feb 14 10:11:59 jmjukebox kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: pinctrl core: initialized pinctrl subsystem Feb 14 10:11:59 jmjukebox kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Feb 14 10:11:59 jmjukebox kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Feb 14 10:11:59 jmjukebox kernel: audit: initializing netlink subsys (disabled) Feb 14 10:11:59 jmjukebox kernel: audit: type=2000 audit(0.010:1): state=initialized audit_enabled=0 res=1 Feb 14 10:11:59 jmjukebox kernel: thermal_sys: Registered thermal governor 'step_wise' Feb 14 10:11:59 jmjukebox kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Feb 14 10:11:59 jmjukebox kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Feb 14 10:11:59 jmjukebox kernel: Serial: AMBA PL011 UART driver Feb 14 10:11:59 jmjukebox kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled Feb 14 10:11:59 jmjukebox kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2024-11-11T15:48:13, variant start Feb 14 10:11:59 jmjukebox kernel: raspberrypi-firmware soc:firmware: Firmware hash is 903570ba72a9e117f92e5499de439f59dd96e417 Feb 14 10:11:59 jmjukebox kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Feb 14 10:11:59 jmjukebox kernel: bcm2835-dma fe007000.dma-controller: DMA legacy API manager, dmachans=0x1 Feb 14 10:11:59 jmjukebox kernel: SCSI subsystem initialized Feb 14 10:11:59 jmjukebox kernel: usbcore: registered new interface driver usbfs Feb 14 10:11:59 jmjukebox kernel: usbcore: registered new interface driver hub Feb 14 10:11:59 jmjukebox kernel: usbcore: registered new device driver usb Feb 14 10:11:59 jmjukebox kernel: pps_core: LinuxPPS API ver. 1 registered Feb 14 10:11:59 jmjukebox kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Feb 14 10:11:59 jmjukebox kernel: PTP clock support registered Feb 14 10:11:59 jmjukebox kernel: vgaarb: loaded Feb 14 10:11:59 jmjukebox kernel: clocksource: Switched to clocksource arch_sys_counter Feb 14 10:11:59 jmjukebox kernel: VFS: Disk quotas dquot_6.6.0 Feb 14 10:11:59 jmjukebox kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Feb 14 10:11:59 jmjukebox kernel: FS-Cache: Loaded Feb 14 10:11:59 jmjukebox kernel: CacheFiles: Loaded Feb 14 10:11:59 jmjukebox kernel: NET: Registered PF_INET protocol family Feb 14 10:11:59 jmjukebox kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: TCP: Hash tables configured (established 8192 bind 8192) Feb 14 10:11:59 jmjukebox kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Feb 14 10:11:59 jmjukebox kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Feb 14 10:11:59 jmjukebox kernel: RPC: Registered named UNIX socket transport module. Feb 14 10:11:59 jmjukebox kernel: RPC: Registered udp transport module. Feb 14 10:11:59 jmjukebox kernel: RPC: Registered tcp transport module. Feb 14 10:11:59 jmjukebox kernel: RPC: Registered tcp-with-tls transport module. Feb 14 10:11:59 jmjukebox kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Feb 14 10:11:59 jmjukebox kernel: PCI: CLS 0 bytes, default 64 Feb 14 10:11:59 jmjukebox kernel: Trying to unpack rootfs image as initramfs... Feb 14 10:11:59 jmjukebox kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available Feb 14 10:11:59 jmjukebox kernel: Freeing initrd memory: 28088K Feb 14 10:11:59 jmjukebox kernel: Initialise system trusted keyrings Feb 14 10:11:59 jmjukebox kernel: workingset: timestamp_bits=14 max_order=20 bucket_order=6 Feb 14 10:11:59 jmjukebox kernel: zbud: loaded Feb 14 10:11:59 jmjukebox kernel: NFS: Registering the id_resolver key type Feb 14 10:11:59 jmjukebox kernel: Key type id_resolver registered Feb 14 10:11:59 jmjukebox kernel: Key type id_legacy registered Feb 14 10:11:59 jmjukebox kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Feb 14 10:11:59 jmjukebox kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Feb 14 10:11:59 jmjukebox kernel: Key type asymmetric registered Feb 14 10:11:59 jmjukebox kernel: Asymmetric key parser 'x509' registered Feb 14 10:11:59 jmjukebox kernel: bounce: pool size: 64 pages Feb 14 10:11:59 jmjukebox kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Feb 14 10:11:59 jmjukebox kernel: io scheduler mq-deadline registered Feb 14 10:11:59 jmjukebox kernel: io scheduler kyber registered Feb 14 10:11:59 jmjukebox kernel: io scheduler bfq registered Feb 14 10:11:59 jmjukebox kernel: pinctrl-bcm2835 fe200000.gpio: GPIO_OUT persistence: yes Feb 14 10:11:59 jmjukebox kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: Feb 14 10:11:59 jmjukebox kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] Feb 14 10:11:59 jmjukebox kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x067fffffff -> 0x0080000000 Feb 14 10:11:59 jmjukebox kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00ffffffff -> 0x0400000000 Feb 14 10:11:59 jmjukebox kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 Feb 14 10:11:59 jmjukebox kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Feb 14 10:11:59 jmjukebox kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x67fffffff] (bus address [0x80000000-0xffffffff]) Feb 14 10:11:59 jmjukebox kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 Feb 14 10:11:59 jmjukebox kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Feb 14 10:11:59 jmjukebox kernel: PCI: bus0: Fast back to back transfers disabled Feb 14 10:11:59 jmjukebox kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Feb 14 10:11:59 jmjukebox kernel: pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator Feb 14 10:11:59 jmjukebox kernel: pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator Feb 14 10:11:59 jmjukebox kernel: pci_bus 0000:01: supply vpcie12v not found, using dummy regulator Feb 14 10:11:59 jmjukebox kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) Feb 14 10:11:59 jmjukebox kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 Feb 14 10:11:59 jmjukebox kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Feb 14 10:11:59 jmjukebox kernel: pci 0000:01:00.0: PME# supported from D0 D3hot Feb 14 10:11:59 jmjukebox kernel: PCI: bus1: Fast back to back transfers disabled Feb 14 10:11:59 jmjukebox kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 Feb 14 10:11:59 jmjukebox kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] Feb 14 10:11:59 jmjukebox kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] Feb 14 10:11:59 jmjukebox kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Feb 14 10:11:59 jmjukebox kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] Feb 14 10:11:59 jmjukebox kernel: pci 0000:00:00.0: Max Payload Size set to 256/ 512 (was 128), Max Read Rq 512 Feb 14 10:11:59 jmjukebox kernel: pci 0000:01:00.0: Max Payload Size set to 256/ 256 (was 128), Max Read Rq 512 Feb 14 10:11:59 jmjukebox kernel: pcieport 0000:00:00.0: enabling device (0000 -> 0002) Feb 14 10:11:59 jmjukebox kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 45 Feb 14 10:11:59 jmjukebox kernel: bcm2708_fb soc:fb: FB found 1 display(s) Feb 14 10:11:59 jmjukebox kernel: Console: switching to colour frame buffer device 80x30 Feb 14 10:11:59 jmjukebox kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480 Feb 14 10:11:59 jmjukebox kernel: iproc-rng200 fe104000.rng: hwrng registered Feb 14 10:11:59 jmjukebox kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Feb 14 10:11:59 jmjukebox kernel: brd: module loaded Feb 14 10:11:59 jmjukebox kernel: loop: module loaded Feb 14 10:11:59 jmjukebox kernel: Loading iSCSI transport class v2.0-870. Feb 14 10:11:59 jmjukebox kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 Feb 14 10:11:59 jmjukebox kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus Feb 14 10:11:59 jmjukebox kernel: usbcore: registered new device driver r8152-cfgselector Feb 14 10:11:59 jmjukebox kernel: usbcore: registered new interface driver r8152 Feb 14 10:11:59 jmjukebox kernel: usbcore: registered new interface driver lan78xx Feb 14 10:11:59 jmjukebox kernel: usbcore: registered new interface driver smsc95xx Feb 14 10:11:59 jmjukebox kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Feb 14 10:11:59 jmjukebox kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 Feb 14 10:11:59 jmjukebox kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0300240000000890 Feb 14 10:11:59 jmjukebox kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Feb 14 10:11:59 jmjukebox kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 Feb 14 10:11:59 jmjukebox kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed Feb 14 10:11:59 jmjukebox kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Feb 14 10:11:59 jmjukebox kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 14 10:11:59 jmjukebox kernel: usb usb1: Product: xHCI Host Controller Feb 14 10:11:59 jmjukebox kernel: usb usb1: Manufacturer: Linux 6.6.62-v7l+ xhci-hcd Feb 14 10:11:59 jmjukebox kernel: usb usb1: SerialNumber: 0000:01:00.0 Feb 14 10:11:59 jmjukebox kernel: hub 1-0:1.0: USB hub found Feb 14 10:11:59 jmjukebox kernel: hub 1-0:1.0: 1 port detected Feb 14 10:11:59 jmjukebox kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Feb 14 10:11:59 jmjukebox kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 14 10:11:59 jmjukebox kernel: usb usb2: Product: xHCI Host Controller Feb 14 10:11:59 jmjukebox kernel: usb usb2: Manufacturer: Linux 6.6.62-v7l+ xhci-hcd Feb 14 10:11:59 jmjukebox kernel: usb usb2: SerialNumber: 0000:01:00.0 Feb 14 10:11:59 jmjukebox kernel: hub 2-0:1.0: USB hub found Feb 14 10:11:59 jmjukebox kernel: hub 2-0:1.0: 4 ports detected Feb 14 10:11:59 jmjukebox kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Feb 14 10:11:59 jmjukebox kernel: dwc_otg: FIQ enabled Feb 14 10:11:59 jmjukebox kernel: dwc_otg: NAK holdoff enabled Feb 14 10:11:59 jmjukebox kernel: dwc_otg: FIQ split-transaction FSM enabled Feb 14 10:11:59 jmjukebox kernel: Module dwc_common_port init Feb 14 10:11:59 jmjukebox kernel: usbcore: registered new interface driver uas Feb 14 10:11:59 jmjukebox kernel: usbcore: registered new interface driver usb-storage Feb 14 10:11:59 jmjukebox kernel: mousedev: PS/2 mouse device common for all mice Feb 14 10:11:59 jmjukebox kernel: sdhci: Secure Digital Host Controller Interface driver Feb 14 10:11:59 jmjukebox kernel: sdhci: Copyright(c) Pierre Ossman Feb 14 10:11:59 jmjukebox kernel: sdhci-pltfm: SDHCI platform and OF driver helper Feb 14 10:11:59 jmjukebox kernel: ledtrig-cpu: registered to indicate activity on CPUs Feb 14 10:11:59 jmjukebox kernel: hid: raw HID events driver (C) Jiri Kosina Feb 14 10:11:59 jmjukebox kernel: usbcore: registered new interface driver usbhid Feb 14 10:11:59 jmjukebox kernel: usbhid: USB HID core driver Feb 14 10:11:59 jmjukebox kernel: Initializing XFRM netlink socket Feb 14 10:11:59 jmjukebox kernel: NET: Registered PF_PACKET protocol family Feb 14 10:11:59 jmjukebox kernel: Key type dns_resolver registered Feb 14 10:11:59 jmjukebox kernel: Registering SWP/SWPB emulation handler Feb 14 10:11:59 jmjukebox kernel: registered taskstats version 1 Feb 14 10:11:59 jmjukebox kernel: Loading compiled-in X.509 certificates Feb 14 10:11:59 jmjukebox kernel: Key type .fscrypt registered Feb 14 10:11:59 jmjukebox kernel: Key type fscrypt-provisioning registered Feb 14 10:11:59 jmjukebox kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Feb 14 10:11:59 jmjukebox kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Feb 14 10:11:59 jmjukebox kernel: fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 51, base_baud = 0) is a PL011 rev2 Feb 14 10:11:59 jmjukebox kernel: serial serial0: tty port ttyAMA1 registered Feb 14 10:11:59 jmjukebox kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Feb 14 10:11:59 jmjukebox kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Feb 14 10:11:59 jmjukebox kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Feb 14 10:11:59 jmjukebox kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Feb 14 10:11:59 jmjukebox kernel: of_cfs_init Feb 14 10:11:59 jmjukebox kernel: of_cfs_init: OK Feb 14 10:11:59 jmjukebox kernel: clk: Disabling unused clocks Feb 14 10:11:59 jmjukebox kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Feb 14 10:11:59 jmjukebox kernel: Freeing unused kernel image (initmem) memory: 2048K Feb 14 10:11:59 jmjukebox kernel: Run /init as init process Feb 14 10:11:59 jmjukebox kernel: with arguments: Feb 14 10:11:59 jmjukebox kernel: /init Feb 14 10:11:59 jmjukebox kernel: splash Feb 14 10:11:59 jmjukebox kernel: nodebug Feb 14 10:11:59 jmjukebox kernel: with environment: Feb 14 10:11:59 jmjukebox kernel: HOME=/ Feb 14 10:11:59 jmjukebox kernel: TERM=linux Feb 14 10:11:59 jmjukebox kernel: numa_policy=interleave Feb 14 10:11:59 jmjukebox kernel: numa=fake=2 Feb 14 10:11:59 jmjukebox kernel: imgpart=UUID=ee200d97-771e-4dc2-bc54-5383b3c7262f Feb 14 10:11:59 jmjukebox kernel: imgfile=/volumio_current.sqsh Feb 14 10:11:59 jmjukebox kernel: bootpart=UUID=6D56-80AF Feb 14 10:11:59 jmjukebox kernel: datapart=UUID=9da5fc58-f342-443d-83b5-60353d527d53 Feb 14 10:11:59 jmjukebox kernel: uuidconfig=cmdline.txt Feb 14 10:11:59 jmjukebox kernel: pcie_aspm=off Feb 14 10:11:59 jmjukebox kernel: bootdelay=7 Feb 14 10:11:59 jmjukebox kernel: use_kmsg=no Feb 14 10:11:59 jmjukebox kernel: mmc1: new high speed SDIO card at address 0001 Feb 14 10:11:59 jmjukebox kernel: mmc0: new ultra high speed DDR50 SDXC card at address 0001 Feb 14 10:11:59 jmjukebox kernel: mmcblk0: mmc0:0001 SD 58.6 GiB Feb 14 10:11:59 jmjukebox kernel: mmcblk0: p1 p2 p3 Feb 14 10:11:59 jmjukebox kernel: mmcblk0: mmc0:0001 SD 58.6 GiB Feb 14 10:11:59 jmjukebox kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Feb 14 10:11:59 jmjukebox kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Feb 14 10:11:59 jmjukebox kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Feb 14 10:11:59 jmjukebox kernel: usb 1-1: Product: USB2.0 Hub Feb 14 10:11:59 jmjukebox kernel: hub 1-1:1.0: USB hub found Feb 14 10:11:59 jmjukebox kernel: hub 1-1:1.0: 4 ports detected Feb 14 10:11:59 jmjukebox kernel: usb 2-2: new SuperSpeed USB device number 2 using xhci_hcd Feb 14 10:11:59 jmjukebox kernel: usb 2-2: New USB device found, idVendor=0bc2, idProduct=ab26, bcdDevice= 1.09 Feb 14 10:11:59 jmjukebox kernel: usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Feb 14 10:11:59 jmjukebox kernel: usb 2-2: Product: BUP Slim BK Feb 14 10:11:59 jmjukebox kernel: usb 2-2: Manufacturer: Seagate Feb 14 10:11:59 jmjukebox kernel: usb 2-2: SerialNumber: NA9VNJ20 Feb 14 10:11:59 jmjukebox kernel: scsi host0: uas Feb 14 10:11:59 jmjukebox kernel: scsi 0:0:0:0: Direct-Access Seagate BUP Slim BK 0109 PQ: 0 ANSI: 6 Feb 14 10:11:59 jmjukebox kernel: sd 0:0:0:0: [sda] 3907029167 512-byte logical blocks: (2.00 TB/1.82 TiB) Feb 14 10:11:59 jmjukebox kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Feb 14 10:11:59 jmjukebox kernel: sd 0:0:0:0: [sda] Write Protect is off Feb 14 10:11:59 jmjukebox kernel: sd 0:0:0:0: [sda] Mode Sense: 53 00 00 08 Feb 14 10:11:59 jmjukebox kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Feb 14 10:11:59 jmjukebox kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes Feb 14 10:11:59 jmjukebox kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes) Feb 14 10:11:59 jmjukebox kernel: sda: sda1 Feb 14 10:11:59 jmjukebox kernel: sd 0:0:0:0: [sda] Attached SCSI disk Feb 14 10:11:59 jmjukebox kernel: fuse: init (API version 7.39) Feb 14 10:11:59 jmjukebox kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Feb 14 10:11:59 jmjukebox kernel: EXT4-fs (mmcblk0p2): recovery complete Feb 14 10:11:59 jmjukebox kernel: EXT4-fs (mmcblk0p2): mounted filesystem ee200d97-771e-4dc2-bc54-5383b3c7262f r/w with ordered data mode. Quota mode: none. Feb 14 10:11:59 jmjukebox kernel: loop0: detected capacity change from 0 to 1004840 Feb 14 10:11:59 jmjukebox kernel: EXT4-fs (mmcblk0p3): recovery complete Feb 14 10:11:59 jmjukebox kernel: EXT4-fs (mmcblk0p3): mounted filesystem 9da5fc58-f342-443d-83b5-60353d527d53 r/w with ordered data mode. Quota mode: none. Feb 14 10:11:59 jmjukebox systemd[1]: System time before build time, advancing clock. Feb 14 10:11:59 jmjukebox kernel: NET: Registered PF_INET6 protocol family Feb 14 10:11:59 jmjukebox kernel: Segment Routing with IPv6 Feb 14 10:11:59 jmjukebox kernel: In-situ OAM (IOAM) with IPv6 Feb 14 10:11:59 jmjukebox 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) Feb 14 10:11:59 jmjukebox systemd[1]: Detected architecture arm. Feb 14 10:11:59 jmjukebox systemd[1]: Set hostname to . Feb 14 10:11:59 jmjukebox 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. Feb 14 10:11:59 jmjukebox systemd[1]: Created slice system-getty.slice. Feb 14 10:11:59 jmjukebox systemd[1]: Listening on Journal Socket. Feb 14 10:11:59 jmjukebox systemd[1]: Starting Load Kernel Modules... Feb 14 10:11:59 jmjukebox systemd[1]: Created slice system-systemd\x2dfsck.slice. Feb 14 10:11:59 jmjukebox systemd[1]: Mounting POSIX Message Queue File System... Feb 14 10:11:59 jmjukebox systemd[1]: Reached target System Time Synchronized. Feb 14 10:11:59 jmjukebox kernel: i2c_dev: i2c /dev entries driver Feb 14 10:11:59 jmjukebox systemd-journald[339]: Journal started Feb 14 10:11:59 jmjukebox systemd-journald[339]: Runtime journal (/run/log/journal/eea64a7df36cabb6e36ce31068484641) is 3.7M, max 30.0M, 26.2M free. Feb 14 10:11:59 jmjukebox systemd-modules-load[324]: Inserted module 'i2c_dev' Aug 09 14:29:13 jmjukebox fake-hwclock[335]: Sat Aug 9 13:29:13 UTC 2025 Aug 09 14:29:13 jmjukebox systemd[1]: Mounted POSIX Message Queue File System. Aug 09 14:29:13 jmjukebox systemd[1]: Started Remount Root and Kernel File Systems. Aug 09 14:29:13 jmjukebox systemd[1]: Mounted RPC Pipe File System. Aug 09 14:29:13 jmjukebox systemd[1]: Mounted Kernel Debug File System. Aug 09 14:29:13 jmjukebox systemd[1]: Started Restore / save the current clock. Aug 09 14:29:13 jmjukebox systemd[1]: dynamicswap.service: Succeeded. Aug 09 14:29:13 jmjukebox systemd[1]: Mounted FUSE Control File System. Aug 09 14:29:13 jmjukebox systemd[1]: Mounted Kernel Configuration File System. Aug 09 14:29:13 jmjukebox systemd[1]: Starting Load/Save Random Seed... Aug 09 14:29:13 jmjukebox systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Aug 09 14:29:13 jmjukebox systemd[1]: Starting Create System Users... Aug 09 14:29:13 jmjukebox systemd[1]: Started Load/Save Random Seed. Aug 09 14:29:13 jmjukebox systemd[1]: Started Create System Users. Aug 09 14:29:13 jmjukebox systemd[1]: Starting Create Static Device Nodes in /dev... Aug 09 14:29:13 jmjukebox systemd[1]: Started udev Coldplug all Devices. Aug 09 14:29:13 jmjukebox systemd[1]: Starting Helper to synchronize boot up for ifupdown... Aug 09 14:29:13 jmjukebox systemd[1]: Started Create Static Device Nodes in /dev. Aug 09 14:29:13 jmjukebox systemd[1]: Starting udev Kernel Device Manager... Aug 09 14:29:13 jmjukebox systemd[1]: Reached target Local File Systems (Pre). Aug 09 14:29:13 jmjukebox systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Aug 09 14:29:13 jmjukebox systemd[1]: Mounting /tmp... Aug 09 14:29:13 jmjukebox systemd[1]: Mounting /var/spool/cups... Aug 09 14:29:13 jmjukebox systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Aug 09 14:29:13 jmjukebox systemd[1]: Mounting /var/log... Aug 09 14:29:13 jmjukebox systemd[1]: Started Helper to synchronize boot up for ifupdown. Aug 09 14:29:13 jmjukebox systemd[1]: Mounted /tmp. Aug 09 14:29:13 jmjukebox systemd[1]: Mounted /var/spool/cups. Aug 09 14:29:13 jmjukebox systemd[1]: Mounted /var/log. Aug 09 14:29:13 jmjukebox systemd[1]: Starting Flush Journal to Persistent Storage... Aug 09 14:29:13 jmjukebox systemd[1]: Mounting /var/spool/cups/tmp... Aug 09 14:29:13 jmjukebox systemd-udevd[360]: Network interface NamePolicy= disabled on kernel command line, ignoring. Aug 09 14:29:13 jmjukebox systemd[1]: Mounted /var/spool/cups/tmp. Aug 09 14:29:13 jmjukebox systemd-journald[339]: Runtime journal (/run/log/journal/eea64a7df36cabb6e36ce31068484641) is 7.5M, max 30.0M, 22.5M free. Aug 09 14:29:13 jmjukebox systemd[1]: Started Flush Journal to Persistent Storage. Aug 09 14:29:13 jmjukebox systemd[1]: Started udev Kernel Device Manager. Aug 09 14:29:13 jmjukebox systemd[1]: Starting Show Plymouth Boot Screen... Aug 09 14:29:13 jmjukebox systemd[1]: plymouth-start.service: Succeeded. Aug 09 14:29:13 jmjukebox systemd[1]: Started Show Plymouth Boot Screen. Aug 09 14:29:13 jmjukebox systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Aug 09 14:29:13 jmjukebox systemd[1]: Reached target Paths. Aug 09 14:29:13 jmjukebox systemd[1]: Reached target Local Encrypted Volumes. Aug 09 14:29:13 jmjukebox systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Aug 09 14:29:13 jmjukebox systemd-udevd[387]: Using default interface naming scheme 'v240'. Aug 09 14:29:13 jmjukebox kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Aug 09 14:29:13 jmjukebox kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Aug 09 14:29:13 jmjukebox kernel: [vc_sm_connected_init]: start Aug 09 14:29:13 jmjukebox kernel: [vc_sm_connected_init]: installed successfully Aug 09 14:29:13 jmjukebox systemd-udevd[387]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 09 14:29:13 jmjukebox systemd-udevd[386]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 09 14:29:13 jmjukebox kernel: rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000 Aug 09 14:29:13 jmjukebox kernel: rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem Aug 09 14:29:13 jmjukebox kernel: mc: Linux media interface: v0.10 Aug 09 14:29:13 jmjukebox kernel: videodev: Linux video capture interface: v2.00 Aug 09 14:29:13 jmjukebox kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Aug 09 14:29:13 jmjukebox kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Aug 09 14:29:13 jmjukebox kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Aug 09 14:29:13 jmjukebox kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Aug 09 14:29:13 jmjukebox kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Aug 09 14:29:13 jmjukebox kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Aug 09 14:29:13 jmjukebox kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Aug 09 14:29:13 jmjukebox kernel: rpivid feb10000.codec: Device registered as /dev/video19 Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Aug 09 14:29:13 jmjukebox kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Aug 09 14:29:13 jmjukebox kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Aug 09 14:29:13 jmjukebox kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Aug 09 14:29:13 jmjukebox kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Aug 09 14:29:13 jmjukebox kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Aug 09 14:29:13 jmjukebox kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Aug 09 14:29:13 jmjukebox kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Aug 09 14:29:13 jmjukebox kernel: Bluetooth: Core ver 2.22 Aug 09 14:29:13 jmjukebox kernel: NET: Registered PF_BLUETOOTH protocol family Aug 09 14:29:13 jmjukebox kernel: Bluetooth: HCI device and connection manager initialized Aug 09 14:29:13 jmjukebox kernel: Bluetooth: HCI socket layer initialized Aug 09 14:29:13 jmjukebox kernel: Bluetooth: L2CAP socket layer initialized Aug 09 14:29:13 jmjukebox kernel: Bluetooth: SCO socket layer initialized Aug 09 14:29:13 jmjukebox kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Aug 09 14:29:13 jmjukebox kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Aug 09 14:29:13 jmjukebox kernel: Bluetooth: HCI UART driver ver 2.3 Aug 09 14:29:13 jmjukebox kernel: Bluetooth: HCI UART protocol H4 registered Aug 09 14:29:13 jmjukebox kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Aug 09 14:29:13 jmjukebox kernel: Bluetooth: HCI UART protocol Broadcom registered Aug 09 14:29:13 jmjukebox kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Aug 09 14:29:14 jmjukebox kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Aug 09 14:29:14 jmjukebox kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Aug 09 14:29:14 jmjukebox kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Aug 09 14:29:14 jmjukebox kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Aug 09 14:29:14 jmjukebox kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Aug 09 14:29:14 jmjukebox kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Aug 09 14:29:14 jmjukebox kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Aug 09 14:29:14 jmjukebox kernel: uart-pl011 fe201000.serial: no DMA platform data Aug 09 14:29:14 jmjukebox kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Aug 09 14:29:14 jmjukebox kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Aug 09 14:29:14 jmjukebox kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Aug 09 14:29:14 jmjukebox kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Aug 09 14:29:14 jmjukebox kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Aug 09 14:29:14 jmjukebox kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Aug 09 14:29:14 jmjukebox kernel: usbcore: registered new interface driver brcmfmac Aug 09 14:29:14 jmjukebox systemd[1]: Found device /dev/disk/by-uuid/6D56-80AF. Aug 09 14:29:14 jmjukebox kernel: Bluetooth: hci0: BCM: chip id 107 Aug 09 14:29:14 jmjukebox kernel: Bluetooth: hci0: BCM: features 0x2f Aug 09 14:29:14 jmjukebox kernel: Bluetooth: hci0: BCM4345C0 Aug 09 14:29:14 jmjukebox kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Aug 09 14:29:14 jmjukebox kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Aug 09 14:29:14 jmjukebox kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Aug 09 14:29:14 jmjukebox 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 Aug 09 14:29:14 jmjukebox kernel: alsactl[494]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Aug 09 14:29:14 jmjukebox systemd-udevd[380]: Using default interface naming scheme 'v240'. Aug 09 14:29:14 jmjukebox systemd-udevd[380]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 09 14:29:14 jmjukebox systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Aug 09 14:29:14 jmjukebox systemd[1]: Condition check resulted in Huge Pages File System being skipped. Aug 09 14:29:14 jmjukebox systemd[1]: Created slice system-bthelper.slice. Aug 09 14:29:14 jmjukebox systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Aug 09 14:29:14 jmjukebox systemd[1]: Starting Show Plymouth Boot Screen... Aug 09 14:29:14 jmjukebox systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Aug 09 14:29:14 jmjukebox systemd[1]: Starting File System Check on /dev/disk/by-uuid/6D56-80AF... Aug 09 14:29:14 jmjukebox systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Aug 09 14:29:14 jmjukebox systemd[1]: Starting Load/Save RF Kill Switch Status... Aug 09 14:29:14 jmjukebox systemd[1]: Started File System Check Daemon to report status. Aug 09 14:29:14 jmjukebox systemd[1]: plymouth-start.service: Succeeded. Aug 09 14:29:14 jmjukebox systemd[1]: Started Show Plymouth Boot Screen. Aug 09 14:29:14 jmjukebox systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Aug 09 14:29:14 jmjukebox systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Aug 09 14:29:14 jmjukebox systemd[1]: Started Load/Save RF Kill Switch Status. Aug 09 14:29:14 jmjukebox systemd-fsck[512]: fsck.fat 4.1 (2017-01-24) Aug 09 14:29:14 jmjukebox systemd-fsck[512]: /dev/mmcblk0p1: 405 files, 166333/184582 clusters Aug 09 14:29:14 jmjukebox systemd[1]: Started File System Check on /dev/disk/by-uuid/6D56-80AF. Aug 09 14:29:14 jmjukebox systemd[1]: Mounting /boot... Aug 09 14:29:14 jmjukebox systemd[1]: Mounted /boot. Aug 09 14:29:14 jmjukebox systemd[1]: Reached target Local File Systems. Aug 09 14:29:14 jmjukebox systemd[1]: Starting Create Volatile Files and Directories... Aug 09 14:29:14 jmjukebox systemd[1]: Started ifup for eth0. Aug 09 14:29:14 jmjukebox systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Aug 09 14:29:14 jmjukebox systemd[1]: Started ifup for wlan0. Aug 09 14:29:14 jmjukebox systemd[1]: Starting Preprocess NFS configuration... Aug 09 14:29:14 jmjukebox systemd[1]: Starting Raise network interfaces... Aug 09 14:29:14 jmjukebox systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Aug 09 14:29:14 jmjukebox systemd[1]: nfs-config.service: Succeeded. Aug 09 14:29:14 jmjukebox systemd[1]: Started Preprocess NFS configuration. Aug 09 14:29:14 jmjukebox systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Aug 09 14:29:14 jmjukebox systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Aug 09 14:29:14 jmjukebox systemd[1]: Reached target NFS client services. Aug 09 14:29:14 jmjukebox systemd[1]: plymouth-read-write.service: Succeeded. Aug 09 14:29:14 jmjukebox systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Aug 09 14:29:14 jmjukebox systemd[1]: Received SIGRTMIN+20 from PID 208 (plymouthd). Aug 09 14:29:14 jmjukebox systemd[1]: Started Create Volatile Files and Directories. Aug 09 14:29:14 jmjukebox systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Aug 09 14:29:14 jmjukebox kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Aug 09 14:29:14 jmjukebox systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Aug 09 14:29:14 jmjukebox systemd[1]: Starting Update UTMP about System Boot/Shutdown... Aug 09 14:29:15 jmjukebox systemd[1]: Starting RPC bind portmap service... Aug 09 14:29:15 jmjukebox systemd[1]: Started Update UTMP about System Boot/Shutdown. Aug 09 14:29:15 jmjukebox systemd[1]: Reached target System Initialization. Aug 09 14:29:15 jmjukebox kernel: Bluetooth: hci0: BCM: features 0x2f Aug 09 14:29:15 jmjukebox kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Aug 09 14:29:15 jmjukebox kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Aug 09 14:29:15 jmjukebox systemd[1]: Listening on triggerhappy.socket. Aug 09 14:29:15 jmjukebox systemd[1]: Started Daily apt download activities. Aug 09 14:29:15 jmjukebox systemd[1]: Started Daily apt upgrade and clean activities. Aug 09 14:29:15 jmjukebox systemd[1]: Started Daily Cleanup of Temporary Directories. Aug 09 14:29:15 jmjukebox systemd[1]: Reached target Timers. Aug 09 14:29:15 jmjukebox systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Aug 09 14:29:15 jmjukebox systemd[1]: Listening on D-Bus System Message Bus Socket. Aug 09 14:29:15 jmjukebox systemd[1]: Reached target Sockets. Aug 09 14:29:15 jmjukebox systemd[1]: Reached target Basic System. Aug 09 14:29:15 jmjukebox systemd[1]: Started volumio-remote-updater.service. Aug 09 14:29:15 jmjukebox systemd[1]: Starting triggerhappy global hotkey daemon... Aug 09 14:29:15 jmjukebox systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Aug 09 14:29:15 jmjukebox systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Aug 09 14:29:15 jmjukebox systemd[1]: Starting Login Service... Aug 09 14:29:15 jmjukebox systemd[1]: Starting dhcpcd on all interfaces... Aug 09 14:29:15 jmjukebox systemd[1]: Started MPD Monitor Service. Aug 09 14:29:15 jmjukebox systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Aug 09 14:29:15 jmjukebox systemd[1]: Started D-Bus System Message Bus. Aug 09 14:29:15 jmjukebox dhcpcd[597]: Not running dhcpcd because /etc/network/interfaces Aug 09 14:29:15 jmjukebox dhcpcd[597]: defines some interfaces that will use a Aug 09 14:29:15 jmjukebox dhcpcd[597]: DHCP client or static address Aug 09 14:29:15 jmjukebox systemd[1]: Starting WPA supplicant... Aug 09 14:29:15 jmjukebox mpd_monitor.sh[598]: MPD Monitor Service: Starting MPD Monitor Service Aug 09 14:29:15 jmjukebox systemd[1]: Starting Configure Bluetooth Modems connected by UART... Aug 09 14:29:15 jmjukebox systemd[1]: Started Volumio Log Rotation Service. Aug 09 14:29:15 jmjukebox systemd[1]: Starting Wireless Services... Aug 09 14:29:15 jmjukebox systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Aug 09 14:29:15 jmjukebox systemd[1]: Starting Volumio Time Update Utility... Aug 09 14:29:15 jmjukebox systemd[1]: Started Volumio Iptables Module. Aug 09 14:29:15 jmjukebox systemd[1]: Started UPnP Renderer front-end to MPD. Aug 09 14:29:15 jmjukebox systemd[1]: Started Manage Sound Card State (restore and store). Aug 09 14:29:15 jmjukebox alsactl[609]: alsactl 1.1.8 daemon started Aug 09 14:29:15 jmjukebox systemd[1]: Starting Save/Restore Sound Card State... Aug 09 14:29:15 jmjukebox volumio-time-update[606]: volumio-time-update-util: Fetching time from Volumio... Aug 09 14:29:15 jmjukebox kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 09 14:29:15 jmjukebox systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Aug 09 14:29:15 jmjukebox systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Aug 09 14:29:15 jmjukebox systemd[1]: Failed to start dhcpcd on all interfaces. Aug 09 14:29:15 jmjukebox thd[594]: Unable to parse trigger line: Aug 09 14:29:15 jmjukebox thd[594]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Aug 09 14:29:15 jmjukebox thd[594]: Unable to parse trigger line: Aug 09 14:29:15 jmjukebox thd[594]: Unable to parse trigger line: Aug 09 14:29:15 jmjukebox thd[594]: Found socket passed from systemd Aug 09 14:29:15 jmjukebox systemd-logind[596]: New seat seat0. Aug 09 14:29:15 jmjukebox kernel: 8021q: 802.1Q VLAN Support v1.8 Aug 09 14:29:15 jmjukebox mpd_monitor.sh[598]: MPD error: Connection refused Aug 09 14:29:15 jmjukebox mpd_monitor.sh[598]: MPD Monitor Service: MPD Appears to be inactive, restarting Aug 09 14:29:15 jmjukebox avahi-daemon[595]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Aug 09 14:29:15 jmjukebox avahi-daemon[595]: Successfully dropped root privileges. Aug 09 14:29:15 jmjukebox avahi-daemon[595]: avahi-daemon 0.7 starting up. Aug 09 14:29:15 jmjukebox mpd_monitor.sh[598]: mpd: no process found Aug 09 14:29:15 jmjukebox dbus-daemon[599]: [system] Successfully activated service 'org.freedesktop.systemd1' Aug 09 14:29:15 jmjukebox systemd[1]: Started Login Service. Aug 09 14:29:15 jmjukebox wpa_supplicant[601]: Successfully initialized wpa_supplicant Aug 09 14:29:15 jmjukebox systemd[1]: Started triggerhappy global hotkey daemon. Aug 09 14:29:15 jmjukebox avahi-daemon[595]: Successfully called chroot(). Aug 09 14:29:15 jmjukebox systemd[1]: Started RPC bind portmap service. Aug 09 14:29:15 jmjukebox avahi-daemon[595]: Successfully dropped remaining capabilities. Aug 09 14:29:15 jmjukebox systemd[1]: hciuart.service: Succeeded. Aug 09 14:29:15 jmjukebox systemd[1]: Started Configure Bluetooth Modems connected by UART. Aug 09 14:29:15 jmjukebox systemd[1]: Started Save/Restore Sound Card State. Aug 09 14:29:15 jmjukebox avahi-daemon[595]: Loading service file /services/volumio.service. Aug 09 14:29:15 jmjukebox systemd[1]: Started WPA supplicant. Aug 09 14:29:15 jmjukebox avahi-daemon[595]: Network interface enumeration completed. Aug 09 14:29:15 jmjukebox avahi-daemon[595]: Server startup complete. Host name is jmjukebox.local. Local service cookie is 2681400906. Aug 09 14:29:15 jmjukebox avahi-daemon[595]: Service "JmJukebox" (/services/volumio.service) successfully established. Aug 09 14:29:15 jmjukebox kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Aug 09 14:29:15 jmjukebox kernel: bcmgenet fd580000.ethernet eth0: Link is Down Aug 09 14:29:15 jmjukebox sh[523]: eth0: waiting for carrier Aug 09 14:29:15 jmjukebox dhcpcd[578]: eth0: waiting for carrier Aug 09 14:29:15 jmjukebox systemd[1]: Started Avahi mDNS/DNS-SD Stack. Aug 09 14:29:15 jmjukebox sh[524]: wlan0=wlan0 Aug 09 14:29:15 jmjukebox systemd[1]: Listening on mpd.socket. Aug 09 14:29:15 jmjukebox systemd[1]: Reached target Sound Card. Aug 09 14:29:15 jmjukebox systemd[1]: Starting Raspberry Pi bluetooth helper... Aug 09 14:29:15 jmjukebox systemd[1]: Reached target Remote File Systems (Pre). Aug 09 14:29:15 jmjukebox systemd[1]: Reached target Remote File Systems. Aug 09 14:29:16 jmjukebox systemd[1]: Starting LSB: Switch to ondemand cpu governor (unless shift key is pressed)... Aug 09 14:29:16 jmjukebox systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Aug 09 14:29:16 jmjukebox systemd[1]: Reached target RPC Port Mapper. Aug 09 14:29:16 jmjukebox systemd[1]: Started Raise network interfaces. Aug 09 14:29:16 jmjukebox systemd[1]: Reached target Network. Aug 09 14:29:16 jmjukebox systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Aug 09 14:29:16 jmjukebox volumio-remote-updater[593]: Error: No active session Aug 09 14:29:16 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:16] [info] asio async_connect error: system:111 (Connection refused) Aug 09 14:29:16 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:16] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 09 14:29:16 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:16] [error] handle_connect error: Underlying Transport Error Aug 09 14:29:16 jmjukebox systemd[1]: Starting Music Player Daemon... Aug 09 14:29:16 jmjukebox systemd[1]: Starting Network Time Service... Aug 09 14:29:16 jmjukebox systemd[1]: Starting OpenBSD Secure Shell server... Aug 09 14:29:16 jmjukebox systemd[1]: Starting Permit User Sessions... Aug 09 14:29:16 jmjukebox systemd[1]: Reached target Network is Online. Aug 09 14:29:16 jmjukebox systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 09 14:29:16 jmjukebox systemd[1]: Starting /etc/rc.local Compatibility... Aug 09 14:29:16 jmjukebox bthelper[704]: Raspberry Pi BDADDR already set Aug 09 14:29:16 jmjukebox systemd[1]: Starting Samba NMB Daemon... Aug 09 14:29:16 jmjukebox systemd[1]: Starting LSB: Brings up/down network automatically... Aug 09 14:29:16 jmjukebox volumio[608]: Could not open config: /tmp/upmpdcli.conf Aug 09 14:29:16 jmjukebox systemd[1]: Started Raspberry Pi bluetooth helper. Aug 09 14:29:16 jmjukebox systemd[1]: Started /etc/rc.local Compatibility. Aug 09 14:29:16 jmjukebox systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 09 14:29:16 jmjukebox systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 09 14:29:16 jmjukebox systemd[1]: Starting Bluetooth service... Aug 09 14:29:16 jmjukebox volumio-time-update[606]: volumio-time-update-util: Date not found in response Aug 09 14:29:16 jmjukebox volumio-time-update[606]: volumio-time-update-util: Retrying in 5 seconds... Aug 09 14:29:16 jmjukebox systemd[1]: Started Permit User Sessions. Aug 09 14:29:16 jmjukebox systemd[1]: iptables.service: Succeeded. Aug 09 14:29:16 jmjukebox haveged[558]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Aug 09 14:29:16 jmjukebox haveged[558]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Aug 09 14:29:16 jmjukebox haveged[558]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99982 Aug 09 14:29:16 jmjukebox haveged[558]: haveged: fills: 0, generated: 0 Aug 09 14:29:16 jmjukebox raspi-config[705]: Checking if shift key is held down:Error opening '/dev/input/event*': No such file or directory Aug 09 14:29:16 jmjukebox raspi-config[705]: No. Switching to ondemand scaling governor. Aug 09 14:29:16 jmjukebox systemd[1]: Started LSB: Switch to ondemand cpu governor (unless shift key is pressed). Aug 09 14:29:16 jmjukebox systemd[1]: Starting Hold until boot process finishes up... Aug 09 14:29:16 jmjukebox systemd[1]: Starting Terminate Plymouth Boot Screen... Aug 09 14:29:16 jmjukebox systemd[1]: Received SIGRTMIN+21 from PID 208 (plymouthd). Aug 09 14:29:16 jmjukebox systemd[1]: Received SIGRTMIN+21 from PID 208 (plymouthd). Aug 09 14:29:16 jmjukebox systemd[1]: plymouth-quit-wait.service: Succeeded. Aug 09 14:29:16 jmjukebox systemd[1]: Started Hold until boot process finishes up. Aug 09 14:29:16 jmjukebox systemd[1]: plymouth-quit.service: Succeeded. Aug 09 14:29:16 jmjukebox systemd[1]: Started Terminate Plymouth Boot Screen. Aug 09 14:29:16 jmjukebox systemd[1]: Started Getty on tty1. Aug 09 14:29:16 jmjukebox systemd[1]: Reached target Login Prompts. Aug 09 14:29:16 jmjukebox ntpd[716]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 09 14:29:16 jmjukebox ntpd[716]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Aug 09 14:29:16 jmjukebox systemd[1]: Started Network Time Service. Aug 09 14:29:16 jmjukebox ntpd[763]: proto: precision = 0.815 usec (-20) Aug 09 14:29:16 jmjukebox ifplugd(eth0)[769]: ifplugd 0.28 initializing. Aug 09 14:29:16 jmjukebox ifplugd(eth0)[769]: Using interface eth0/2C:CF:67:64:A9:29 with driver (version: 6.6.62-v7l+) Aug 09 14:29:16 jmjukebox ifplugd(eth0)[769]: Using detection mode: SIOCETHTOOL Aug 09 14:29:16 jmjukebox ifplugd(eth0)[769]: Initialization complete, link beat not detected. Aug 09 14:29:16 jmjukebox ntpd[763]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 09 14:29:16 jmjukebox ntpd[763]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 09 14:29:16 jmjukebox ntpd[763]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 225 days ago Aug 09 14:29:16 jmjukebox ntpd[763]: Listen and drop on 0 v6wildcard [::]:123 Aug 09 14:29:16 jmjukebox ntpd[763]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 09 14:29:16 jmjukebox ntpd[763]: Listen normally on 2 lo 127.0.0.1:123 Aug 09 14:29:16 jmjukebox ntpd[763]: Listening on routing socket on fd #19 for interface updates Aug 09 14:29:16 jmjukebox ntpd[763]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 09 14:29:16 jmjukebox ntpd[763]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 09 14:29:16 jmjukebox sshd[774]: Server listening on 0.0.0.0 port 22. Aug 09 14:29:16 jmjukebox sshd[774]: Server listening on :: port 22. Aug 09 14:29:16 jmjukebox systemd[1]: Started OpenBSD Secure Shell server. Aug 09 14:29:16 jmjukebox ifplugd[731]: Network Interface Plugging Daemon...start eth0...done. Aug 09 14:29:16 jmjukebox systemd[1]: Started LSB: Brings up/down network automatically. Aug 09 14:29:16 jmjukebox loadcpufreq[706]: Loading cpufreq kernel modules...done (none). Aug 09 14:29:16 jmjukebox bluetoothd[736]: Bluetooth daemon 5.50 Aug 09 14:29:16 jmjukebox systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Aug 09 14:29:16 jmjukebox sudo[714]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 09 14:29:16 jmjukebox sudo[714]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:16 jmjukebox systemd[1]: Starting LSB: set CPUFreq kernel parameters... Aug 09 14:29:16 jmjukebox sudo[714]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 09 14:29:16 jmjukebox sudo[714]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:16 jmjukebox bluetoothd[736]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Aug 09 14:29:16 jmjukebox bluetoothd[736]: Starting SDP server Aug 09 14:29:16 jmjukebox bluetoothd[736]: Excluding (cli) sap Aug 09 14:29:16 jmjukebox systemd[1]: Started Bluetooth service. Aug 09 14:29:16 jmjukebox systemd[1]: Reached target Bluetooth. Aug 09 14:29:16 jmjukebox kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Aug 09 14:29:16 jmjukebox kernel: Bluetooth: BNEP filters: protocol multicast Aug 09 14:29:16 jmjukebox kernel: Bluetooth: BNEP socket layer initialized Aug 09 14:29:16 jmjukebox bluetoothd[736]: Bluetooth management interface 1.22 initialized Aug 09 14:29:16 jmjukebox dbus-daemon[599]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=736 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Aug 09 14:29:16 jmjukebox kernel: Bluetooth: MGMT ver 1.22 Aug 09 14:29:16 jmjukebox bluetoothd[736]: Failed to set privacy: Rejected (0x0b) Aug 09 14:29:17 jmjukebox systemd[1]: Starting Hostname Service... Aug 09 14:29:17 jmjukebox cpufrequtils[800]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Aug 09 14:29:17 jmjukebox systemd[1]: Started LSB: set CPUFreq kernel parameters. Aug 09 14:29:17 jmjukebox dbus-daemon[599]: [system] Successfully activated service 'org.freedesktop.hostname1' Aug 09 14:29:17 jmjukebox systemd[1]: Started Hostname Service. Aug 09 14:29:17 jmjukebox nmbd[735]: [2025/08/09 14:29:17.483660, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Aug 09 14:29:17 jmjukebox nmbd[735]: started asyncdns process 817 Aug 09 14:29:17 jmjukebox nmbd[735]: [2025/08/09 14:29:17.485204, 0] ../lib/util/become_daemon.c:149(daemon_status) Aug 09 14:29:17 jmjukebox nmbd[735]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Aug 09 14:29:17 jmjukebox nmbd[735]: [2025/08/09 14:29:17.485353, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Aug 09 14:29:17 jmjukebox nmbd[735]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Aug 09 14:29:17 jmjukebox ntpd[763]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Aug 09 14:29:17 jmjukebox wireless.js[605]: Cleaning previous... Aug 09 14:29:17 jmjukebox sudo[825]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 09 14:29:17 jmjukebox sudo[825]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:17 jmjukebox sudo[825]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:17 jmjukebox sudo[827]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 09 14:29:17 jmjukebox sudo[827]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:18 jmjukebox sudo[827]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:18 jmjukebox wireless.js[605]: Stopped aP Aug 09 14:29:18 jmjukebox sudo[834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Aug 09 14:29:18 jmjukebox sudo[834]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:18 jmjukebox kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 09 14:29:18 jmjukebox sudo[834]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:18 jmjukebox sudo[836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Aug 09 14:29:18 jmjukebox sudo[836]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:18 jmjukebox sudo[836]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:18 jmjukebox ntpd[763]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Aug 09 14:29:18 jmjukebox sudo[843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Aug 09 14:29:18 jmjukebox sudo[843]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:18 jmjukebox sudo[843]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:18 jmjukebox sudo[845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Aug 09 14:29:18 jmjukebox sudo[845]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:18 jmjukebox mpd[803]: Aug 09 14:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 09 14:29:19 jmjukebox systemd[1]: Started Music Player Daemon. Aug 09 14:29:19 jmjukebox mpd_monitor.sh[598]: MPD Monitor Service: MPD restarted due to no mpc output. Aug 09 14:29:19 jmjukebox ntpd[763]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Aug 09 14:29:19 jmjukebox systemd[1]: systemd-rfkill.service: Succeeded. Aug 09 14:29:20 jmjukebox ntpd[763]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Aug 09 14:29:20 jmjukebox sudo[845]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:20 jmjukebox wireless.js[605]: SETTING APPROPRIATE REG DOMAIN: DE Aug 09 14:29:20 jmjukebox sudo[853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Aug 09 14:29:20 jmjukebox sudo[853]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:20 jmjukebox sudo[853]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:21 jmjukebox sudo[855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Aug 09 14:29:21 jmjukebox sudo[855]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:21 jmjukebox sudo[855]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:21 jmjukebox wireless.js[605]: SUCCESSFULLY SET NEW REGDOMAIN: DE Aug 09 14:29:21 jmjukebox wireless.js[605]: Start wireless flow Aug 09 14:29:21 jmjukebox wireless.js[605]: Stopped hotspot (if there).. Aug 09 14:29:21 jmjukebox sudo[860]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 09 14:29:21 jmjukebox sudo[860]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:21 jmjukebox sudo[860]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:21 jmjukebox sudo[862]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 09 14:29:21 jmjukebox sudo[862]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:21 jmjukebox bthelper[704]: Changing power off succeeded Aug 09 14:29:21 jmjukebox bthelper[704]: [CHG] Controller 2C:CF:67:64:A9:2B Powered: no Aug 09 14:29:21 jmjukebox bthelper[704]: [CHG] Controller 2C:CF:67:64:A9:2B Discovering: no Aug 09 14:29:21 jmjukebox bthelper[704]: [CHG] Controller 2C:CF:67:64:A9:2B Class: 0x00000000 Aug 09 14:29:21 jmjukebox volumio-time-update[606]: volumio-time-update-util: Fetching time from Volumio... Aug 09 14:29:21 jmjukebox volumio-time-update[606]: volumio-time-update-util: Date not found in response Aug 09 14:29:21 jmjukebox volumio-time-update[606]: volumio-time-update-util: Retrying in 5 seconds... Aug 09 14:29:21 jmjukebox bthelper[704]: [CHG] Controller 2C:CF:67:64:A9:2B Class: 0x0000041c Aug 09 14:29:21 jmjukebox bthelper[704]: Changing power on succeeded Aug 09 14:29:21 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:21] [info] asio async_connect error: system:111 (Connection refused) Aug 09 14:29:21 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:21] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 09 14:29:21 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:21] [error] handle_connect error: Underlying Transport Error Aug 09 14:29:21 jmjukebox sudo[862]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:21 jmjukebox wireless.js[605]: DHCP IP Aug 09 14:29:21 jmjukebox wireless.js[605]: Start ap Aug 09 14:29:21 jmjukebox wpa_supplicant[877]: Successfully initialized wpa_supplicant Aug 09 14:29:21 jmjukebox sudo[878]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Aug 09 14:29:21 jmjukebox sudo[878]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:21 jmjukebox kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 09 14:29:21 jmjukebox dhcpcd[879]: dev: loaded udev Aug 09 14:29:21 jmjukebox dhcpcd-run-hooks[897]: wlan0: starting wpa_supplicant Aug 09 14:29:21 jmjukebox dhcpcd-run-hooks[902]: wlan0: failed to start wpa_supplicant Aug 09 14:29:21 jmjukebox dhcpcd-run-hooks[903]: 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 Aug 09 14:29:21 jmjukebox dhcpcd[879]: wlan0: connected to Access Point `' Aug 09 14:29:21 jmjukebox dhcpcd[879]: no interfaces have a carrier Aug 09 14:29:21 jmjukebox dhcpcd[879]: forked to background, child pid 913 Aug 09 14:29:21 jmjukebox dhcpcd[913]: eth0: waiting for carrier Aug 09 14:29:21 jmjukebox dhcpcd[913]: wlan0: waiting for carrier Aug 09 14:29:21 jmjukebox sudo[878]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:22 jmjukebox wireless.js[605]: trying... Aug 09 14:29:22 jmjukebox sudo[915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:22 jmjukebox sudo[915]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:22 jmjukebox sudo[915]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:23 jmjukebox wireless.js[605]: trying... Aug 09 14:29:23 jmjukebox sudo[918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:23 jmjukebox sudo[918]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:23 jmjukebox sudo[918]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:24 jmjukebox wireless.js[605]: trying... Aug 09 14:29:24 jmjukebox sudo[921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:24 jmjukebox sudo[921]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:24 jmjukebox sudo[921]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:25 jmjukebox wireless.js[605]: trying... Aug 09 14:29:25 jmjukebox sudo[924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:25 jmjukebox sudo[924]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:25 jmjukebox sudo[924]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:26 jmjukebox volumio-time-update[606]: volumio-time-update-util: Fetching time from Volumio... Aug 09 14:29:26 jmjukebox volumio-time-update[606]: volumio-time-update-util: Date not found in response Aug 09 14:29:26 jmjukebox volumio-time-update[606]: volumio-time-update-util: Retrying in 5 seconds... Aug 09 14:29:26 jmjukebox wireless.js[605]: trying... Aug 09 14:29:26 jmjukebox sudo[932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:26 jmjukebox sudo[932]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:26 jmjukebox sudo[932]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:27 jmjukebox wireless.js[605]: trying... Aug 09 14:29:27 jmjukebox sudo[935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:27 jmjukebox sudo[935]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:27 jmjukebox sudo[935]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:27 jmjukebox wpa_supplicant[901]: wlan0: Trying to associate with SSID 'Vodafone-8E504E' Aug 09 14:29:28 jmjukebox wpa_supplicant[901]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Aug 09 14:29:28 jmjukebox wireless.js[605]: trying... Aug 09 14:29:28 jmjukebox sudo[939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:28 jmjukebox sudo[939]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:28 jmjukebox sudo[939]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:29 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:29] [info] asio async_connect error: system:111 (Connection refused) Aug 09 14:29:29 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:29] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 09 14:29:29 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:29] [error] handle_connect error: Underlying Transport Error Aug 09 14:29:29 jmjukebox wireless.js[605]: trying... Aug 09 14:29:29 jmjukebox sudo[942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:29 jmjukebox sudo[942]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:29 jmjukebox sudo[942]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:30 jmjukebox wireless.js[605]: trying... Aug 09 14:29:30 jmjukebox sudo[945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:30 jmjukebox sudo[945]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:30 jmjukebox sudo[945]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:31 jmjukebox volumio-time-update[606]: volumio-time-update-util: Fetching time from Volumio... Aug 09 14:29:31 jmjukebox volumio-time-update[606]: volumio-time-update-util: Date not found in response Aug 09 14:29:31 jmjukebox volumio-time-update[606]: volumio-time-update-util: Retrying in 5 seconds... Aug 09 14:29:31 jmjukebox wireless.js[605]: trying... Aug 09 14:29:31 jmjukebox sudo[953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:31 jmjukebox sudo[953]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:31 jmjukebox sudo[953]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:32 jmjukebox wireless.js[605]: trying... Aug 09 14:29:32 jmjukebox sudo[956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:32 jmjukebox sudo[956]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:32 jmjukebox sudo[956]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:33 jmjukebox wireless.js[605]: trying... Aug 09 14:29:33 jmjukebox sudo[959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:33 jmjukebox sudo[959]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:33 jmjukebox sudo[959]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:34 jmjukebox wpa_supplicant[901]: wlan0: Trying to associate with SSID 'Vodafone-8E504E' Aug 09 14:29:34 jmjukebox dhcpcd[913]: wlan0: carrier acquired Aug 09 14:29:34 jmjukebox dhcpcd[913]: wlan0: connected to Access Point `Vodafone-8E504E' Aug 09 14:29:34 jmjukebox wpa_supplicant[901]: wlan0: Associated with c0:f6:ec:8e:50:58 Aug 09 14:29:34 jmjukebox wpa_supplicant[901]: wlan0: CTRL-EVENT-CONNECTED - Connection to c0:f6:ec:8e:50:58 completed [id=0 id_str=] Aug 09 14:29:34 jmjukebox wpa_supplicant[901]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 09 14:29:34 jmjukebox wpa_supplicant[901]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=PT Aug 09 14:29:34 jmjukebox dhcpcd[913]: DUID 00:01:00:01:2f:db:1d:e5:2c:cf:67:64:a9:2a Aug 09 14:29:34 jmjukebox dhcpcd[913]: wlan0: IAID 67:64:a9:2a Aug 09 14:29:34 jmjukebox dhcpcd[913]: wlan0: adding address fe80::684:9af3:3932:98d2 Aug 09 14:29:34 jmjukebox dhcpcd[913]: ipv6_addaddr1: Permission denied Aug 09 14:29:34 jmjukebox dhcpcd[913]: wlan0: carrier lost Aug 09 14:29:34 jmjukebox dhcpcd[913]: wlan0: carrier acquired Aug 09 14:29:34 jmjukebox dhcpcd[913]: wlan0: IAID 67:64:a9:2a Aug 09 14:29:34 jmjukebox wireless.js[605]: trying... Aug 09 14:29:34 jmjukebox sudo[974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:34 jmjukebox sudo[974]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:34 jmjukebox sudo[974]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:34 jmjukebox wpa_supplicant[901]: RRM: Ignoring radio measurement request: Not RRM network Aug 09 14:29:34 jmjukebox dhcpcd[913]: wlan0: soliciting an IPv6 router Aug 09 14:29:35 jmjukebox dhcpcd[913]: wlan0: rebinding lease of 192.168.1.190 Aug 09 14:29:35 jmjukebox dhcpcd[913]: wlan0: probing address 192.168.1.190/24 Aug 09 14:29:35 jmjukebox wireless.js[605]: trying... Aug 09 14:29:35 jmjukebox sudo[977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:35 jmjukebox sudo[977]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:35 jmjukebox sudo[977]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:36 jmjukebox volumio-time-update[606]: volumio-time-update-util: Fetching time from Volumio... Aug 09 14:29:36 jmjukebox volumio-time-update[606]: volumio-time-update-util: Date not found in response Aug 09 14:29:36 jmjukebox volumio-time-update[606]: volumio-time-update-util: Retrying in 5 seconds... Aug 09 14:29:36 jmjukebox wireless.js[605]: trying... Aug 09 14:29:36 jmjukebox sudo[985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:36 jmjukebox sudo[985]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:36 jmjukebox sudo[985]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:37 jmjukebox wireless.js[605]: trying... Aug 09 14:29:37 jmjukebox sudo[988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:37 jmjukebox sudo[988]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:37 jmjukebox sudo[988]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:38 jmjukebox wireless.js[605]: trying... Aug 09 14:29:38 jmjukebox sudo[991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:38 jmjukebox sudo[991]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:38 jmjukebox sudo[991]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:39 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:39] [info] asio async_connect error: system:111 (Connection refused) Aug 09 14:29:39 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:39] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 09 14:29:39 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:29:39] [error] handle_connect error: Underlying Transport Error Aug 09 14:29:39 jmjukebox wireless.js[605]: trying... Aug 09 14:29:39 jmjukebox sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:39 jmjukebox sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:39 jmjukebox sudo[997]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:40 jmjukebox wireless.js[605]: trying... Aug 09 14:29:40 jmjukebox sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:40 jmjukebox sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:40 jmjukebox sudo[1000]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:40 jmjukebox dhcpcd[913]: wlan0: leased 192.168.1.190 for 3600 seconds Aug 09 14:29:40 jmjukebox avahi-daemon[595]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.190. Aug 09 14:29:40 jmjukebox dhcpcd[913]: wlan0: adding route to 192.168.1.0/24 Aug 09 14:29:40 jmjukebox avahi-daemon[595]: New relevant interface wlan0.IPv4 for mDNS. Aug 09 14:29:40 jmjukebox dhcpcd[913]: wlan0: adding default route via 192.168.1.1 Aug 09 14:29:40 jmjukebox avahi-daemon[595]: Registering new address record for 192.168.1.190 on wlan0.IPv4. Aug 09 14:29:41 jmjukebox volumio-time-update[606]: volumio-time-update-util: Fetching time from Volumio... Aug 09 14:29:41 jmjukebox volumio-time-update[606]: volumio-time-update-util: Setting system time to: 2025-08-09 14:33:59 Aug 09 14:29:41 jmjukebox sudo[1028]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-08-09 14:33:59 Aug 09 14:29:41 jmjukebox sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:41 jmjukebox dbus-daemon[599]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.9' (uid=0 pid=1029 comm="timedatectl set-time 2025-08-09 14:33:59 ") Aug 09 14:29:41 jmjukebox systemd[1]: Starting Time & Date Service... Aug 09 14:29:41 jmjukebox wireless.js[605]: trying... Aug 09 14:29:41 jmjukebox sudo[1032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 09 14:29:41 jmjukebox sudo[1032]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:41 jmjukebox sudo[1032]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:41 jmjukebox wireless.js[605]: Connected to: ----Vodafone-8E504E Aug 09 14:29:41 jmjukebox wireless.js[605]: ---- Aug 09 14:29:41 jmjukebox sudo[1035]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 09 14:29:41 jmjukebox sudo[1035]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:29:41 jmjukebox sudo[1035]: pam_unix(sudo:session): session closed for user root Aug 09 14:29:41 jmjukebox wireless.js[605]: ... joined AP, wlan0 IPv4 is 192.168.1.190, ipV6 is undefined Aug 09 14:29:41 jmjukebox wireless.js[605]: It's done! AP Aug 09 14:29:41 jmjukebox dbus-daemon[599]: [system] Successfully activated service 'org.freedesktop.timedate1' Aug 09 14:29:41 jmjukebox systemd[1]: Started Time & Date Service. Aug 09 14:33:59 jmjukebox systemd-timedated[1030]: Changed local time to Sat Aug 9 14:33:59 2025 Aug 09 14:33:59 jmjukebox sudo[1028]: pam_unix(sudo:session): session closed for user root Aug 09 14:33:59 jmjukebox volumio-time-update[606]: volumio-time-update-util: System time updated successfully. Aug 09 14:33:59 jmjukebox systemd[1]: Started Volumio Time Update Utility. Aug 09 14:33:59 jmjukebox systemd[1]: Started Wireless Services. Aug 09 14:33:59 jmjukebox kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 09 14:33:59 jmjukebox systemd[1]: Started Volumio Backend Module. Aug 09 14:33:59 jmjukebox systemd[1]: Started Volumio Cpu Tweaker. Aug 09 14:33:59 jmjukebox volumio-cpu-tweak[1041]: Setting RT Priority for mpd Aug 09 14:33:59 jmjukebox volumio-cpu-tweak[1041]: Setting MPD Affinity Aug 09 14:33:59 jmjukebox volumio-cpu-tweak[1041]: pid 803's current affinity mask: f Aug 09 14:33:59 jmjukebox volumio-cpu-tweak[1041]: pid 803's new affinity mask: 3 Aug 09 14:33:59 jmjukebox volumio-cpu-tweak[1041]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Aug 09 14:33:59 jmjukebox volumio-cpu-tweak[1041]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Aug 09 14:33:59 jmjukebox systemd[1]: volumio_cpu_tweak.service: Succeeded. Aug 09 14:33:59 jmjukebox nmbd[735]: [2025/08/09 14:33:59.790672, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 09 14:33:59 jmjukebox systemd[1]: Started Samba NMB Daemon. Aug 09 14:33:59 jmjukebox nmbd[735]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Aug 09 14:33:59 jmjukebox systemd[1]: Starting Samba Winbind Daemon... Aug 09 14:33:59 jmjukebox ntpd[763]: Listen normally on 3 wlan0 192.168.1.190:123 Aug 09 14:33:59 jmjukebox ntpd[763]: new interface(s) found: waking up resolver Aug 09 14:34:00 jmjukebox winbindd[1057]: [2025/08/09 14:34:00.047569, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Aug 09 14:34:00 jmjukebox winbindd[1057]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Aug 09 14:34:00 jmjukebox winbindd[1057]: [2025/08/09 14:34:00.066168, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 09 14:34:00 jmjukebox winbindd[1057]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Aug 09 14:34:00 jmjukebox systemd[1]: Started Samba Winbind Daemon. Aug 09 14:34:00 jmjukebox systemd[1]: Starting Samba SMB Daemon... Aug 09 14:34:00 jmjukebox smbd[1062]: [2025/08/09 14:34:00.527874, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 09 14:34:00 jmjukebox systemd[1]: Started Samba SMB Daemon. Aug 09 14:34:00 jmjukebox smbd[1062]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Aug 09 14:34:00 jmjukebox systemd[1]: Reached target Multi-User System. Aug 09 14:34:00 jmjukebox systemd[1]: Reached target Graphical Interface. Aug 09 14:34:00 jmjukebox systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 09 14:34:00 jmjukebox systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Aug 09 14:34:00 jmjukebox systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 09 14:34:00 jmjukebox systemd[1]: Startup finished in 12.443s (kernel) + 31.421s (userspace) = 43.865s. Aug 09 14:34:00 jmjukebox volumio[1040]: info: ------------------------------------------- Aug 09 14:34:00 jmjukebox volumio[1040]: info: ----- Volumio3 ---- Aug 09 14:34:00 jmjukebox volumio[1040]: info: ------------------------------------------- Aug 09 14:34:00 jmjukebox volumio[1040]: info: ----- System startup ---- Aug 09 14:34:00 jmjukebox volumio[1040]: info: ------------------------------------------- Aug 09 14:34:01 jmjukebox volumio[1040]: info: MYVOLUMIO Environment detected Aug 09 14:34:01 jmjukebox volumio[1040]: info: Plugin folders cleanup Aug 09 14:34:01 jmjukebox volumio[1040]: info: Scanning into folder /volumio/app/plugins/ Aug 09 14:34:01 jmjukebox volumio[1040]: info: Scanning category audio_interface Aug 09 14:34:01 jmjukebox volumio[1040]: info: Scanning category miscellanea Aug 09 14:34:01 jmjukebox volumio[1040]: info: Scanning category music_service Aug 09 14:34:01 jmjukebox volumio[1040]: info: Scanning category plugins.json Aug 09 14:34:01 jmjukebox volumio[1040]: info: Scanning category system_controller Aug 09 14:34:01 jmjukebox volumio[1040]: info: Scanning category user_interface Aug 09 14:34:01 jmjukebox volumio[1040]: info: Scanning into folder /data/plugins/ Aug 09 14:34:01 jmjukebox volumio[1040]: info: Scanning category audio_interface Aug 09 14:34:01 jmjukebox volumio[1040]: info: Scanning category music_service Aug 09 14:34:01 jmjukebox volumio[1040]: info: Plugin folders cleanup completed Aug 09 14:34:01 jmjukebox volumio[1040]: info: ------------------------------------------- Aug 09 14:34:01 jmjukebox volumio[1040]: info: ----- Core plugins startup ---- Aug 09 14:34:01 jmjukebox volumio[1040]: info: ------------------------------------------- Aug 09 14:34:01 jmjukebox volumio[1040]: info: Loading plugins from folder /volumio/app/plugins/ Aug 09 14:34:01 jmjukebox volumio[1040]: info: Adding plugin upnp to MyMusic Plugins Aug 09 14:34:01 jmjukebox volumio[1040]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 09 14:34:01 jmjukebox volumio[1040]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 09 14:34:01 jmjukebox volumio[1040]: info: Loading plugins from folder /data/plugins/ Aug 09 14:34:01 jmjukebox volumio[1040]: info: Loading plugin "system"... Aug 09 14:34:01 jmjukebox volumio[1040]: info: Loading plugin "appearance"... Aug 09 14:34:02 jmjukebox systemd[1]: systemd-fsckd.service: Succeeded. Aug 09 14:34:02 jmjukebox volumio[1040]: info: Loading plugin "network"... Aug 09 14:34:02 jmjukebox volumio[1040]: info: Refreshing Cached IP Addresses Aug 09 14:34:02 jmjukebox sudo[1085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 09 14:34:02 jmjukebox sudo[1085]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:02 jmjukebox sudo[1085]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:02 jmjukebox sudo[1087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 09 14:34:02 jmjukebox sudo[1087]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:02 jmjukebox sudo[1087]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:02 jmjukebox volumio[1040]: info: Loading plugin "services"... Aug 09 14:34:02 jmjukebox volumio[1040]: info: Loading plugin "alsa_controller"... Aug 09 14:34:02 jmjukebox sudo[1098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 09 14:34:02 jmjukebox sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:02 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 09 14:34:02 jmjukebox volumio[1040]: info: Loading plugin "wizard"... Aug 09 14:34:02 jmjukebox volumio[1040]: info: Loading plugin "networkfs"... Aug 09 14:34:02 jmjukebox volumio[1040]: info: Starting Udev Watcher for removable devices Aug 09 14:34:02 jmjukebox volumio[1040]: info: Ignoring mount for partition: boot Aug 09 14:34:02 jmjukebox volumio[1040]: info: Ignoring mount for partition: volumio Aug 09 14:34:02 jmjukebox volumio[1040]: info: Ignoring mount for partition: volumio_data Aug 09 14:34:02 jmjukebox volumio[1040]: info: Mounting Device JMO_2T Aug 09 14:34:02 jmjukebox sudo[1116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/JMO_2T -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 09 14:34:02 jmjukebox sudo[1116]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:03 jmjukebox sh[523]: timed out Aug 09 14:34:03 jmjukebox dhcpcd[578]: timed out Aug 09 14:34:03 jmjukebox sh[523]: dhcpcd exited Aug 09 14:34:03 jmjukebox dhcpcd[578]: dhcpcd exited Aug 09 14:34:03 jmjukebox sh[523]: ifup: failed to bring up eth0 Aug 09 14:34:03 jmjukebox systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Aug 09 14:34:03 jmjukebox systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Aug 09 14:34:03 jmjukebox ntfs-3g[1120]: Version 2017.3.23AR.3 integrated FUSE 28 Aug 09 14:34:03 jmjukebox ntfs-3g[1120]: Mounted /dev/sda1 (Read-Write, label "JMO 2T", NTFS 3.1) Aug 09 14:34:03 jmjukebox ntfs-3g[1120]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 09 14:34:03 jmjukebox ntfs-3g[1120]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Aug 09 14:34:03 jmjukebox ntfs-3g[1120]: Global ownership and permissions enforced, configuration type 7 Aug 09 14:34:03 jmjukebox sudo[1116]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:03 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 09 14:34:03 jmjukebox volumio[1040]: info: Loading plugin "volumio_command_line_client"... Aug 09 14:34:03 jmjukebox volumio[1040]: info: Loading plugin "upnp"... Aug 09 14:34:03 jmjukebox volumio[1040]: info: [1754746443850] Starting Upmpd Daemon Aug 09 14:34:03 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 09 14:34:03 jmjukebox volumio[1040]: info: Loading plugin "my_music"... Aug 09 14:34:03 jmjukebox volumio[1040]: info: Loading plugin "mpd"... Aug 09 14:34:04 jmjukebox volumio[1040]: info: Loading plugin "upnp_browser"... Aug 09 14:34:04 jmjukebox volumio[1040]: info: Loading plugin "alarm-clock"... Aug 09 14:34:04 jmjukebox systemd[1]: systemd-hostnamed.service: Succeeded. Aug 09 14:34:04 jmjukebox volumio[1040]: info: Loading plugin "airplay_emulation"... Aug 09 14:34:04 jmjukebox volumio[1040]: info: Starting Shairport Sync Aug 09 14:34:04 jmjukebox volumio[1040]: info: Loading plugin "last_100"... Aug 09 14:34:04 jmjukebox volumio[1040]: info: Loading plugin "webradio"... Aug 09 14:34:04 jmjukebox volumio[1040]: info: Loading plugin "i2s_dacs"... Aug 09 14:34:04 jmjukebox volumio[1040]: info: I2S DAC not set, start Auto-detection Aug 09 14:34:04 jmjukebox volumio[1040]: info: Loading plugin "volumiodiscovery"... Aug 09 14:34:04 jmjukebox volumio[1040]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 09 14:34:04 jmjukebox volumio[1040]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 09 14:34:04 jmjukebox node[1040]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 09 14:34:04 jmjukebox volumio[1040]: *** WARNING *** For more information see Aug 09 14:34:04 jmjukebox volumio[1040]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 09 14:34:04 jmjukebox volumio[1040]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 09 14:34:04 jmjukebox volumio[1040]: *** WARNING *** For more information see Aug 09 14:34:04 jmjukebox node[1040]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 09 14:34:04 jmjukebox node[1040]: *** WARNING *** For more information see Aug 09 14:34:04 jmjukebox node[1040]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 09 14:34:04 jmjukebox node[1040]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 09 14:34:04 jmjukebox node[1040]: *** WARNING *** For more information see Aug 09 14:34:04 jmjukebox volumio[1040]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 09 14:34:04 jmjukebox volumio[1040]: info: Discovery: Started advertising with name: JmJukebox Aug 09 14:34:04 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 09 14:34:04 jmjukebox volumio[1040]: info: Loading plugin "spop"... Aug 09 14:34:05 jmjukebox volumio[1040]: info: Loading plugin "outputs"... Aug 09 14:34:05 jmjukebox volumio[1040]: info: Loading plugin "albumart"... Aug 09 14:34:05 jmjukebox volumio[1040]: info: Plugin example_plugin is not enabled Aug 09 14:34:05 jmjukebox volumio[1040]: info: Loading plugin "inputs"... Aug 09 14:34:05 jmjukebox volumio[1040]: info: Loading plugin "updater_comm"... Aug 09 14:34:05 jmjukebox sudo[1098]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:06 jmjukebox volumio[1040]: info: Plugin mpdemulation is not enabled Aug 09 14:34:06 jmjukebox volumio[1040]: info: Loading plugin "rest_api"... Aug 09 14:34:06 jmjukebox volumio[1040]: info: Loading plugin "websocket"... Aug 09 14:34:06 jmjukebox volumio[1040]: info: Starting Socket.io Server version 2.3.0 Aug 09 14:34:06 jmjukebox volumio[1040]: info: Loading plugin "fusiondsp"... Aug 09 14:34:06 jmjukebox volumio[1040]: Forking 3 albumart workers Aug 09 14:34:06 jmjukebox volumio[1040]: info: Applying required configuration parameters for plugin fusiondsp Aug 09 14:34:06 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:34:06] [connect] Successful connection Aug 09 14:34:06 jmjukebox volumio[1040]: info: Loading i18n strings for locale en Aug 09 14:34:06 jmjukebox volumio[1040]: Updating browse sources language Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 09 14:34:06 jmjukebox volumio[1040]: Starting albumart workers Aug 09 14:34:06 jmjukebox volumio[1040]: Starting albumart workers Aug 09 14:34:06 jmjukebox volumio[1040]: Starting albumart workers Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::initPlayerControls Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 09 14:34:06 jmjukebox volumio[1040]: Express server listening on port 3000 Aug 09 14:34:06 jmjukebox volumio[1040]: [Metrics] WebUI: 6s 699.81ms Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreStateMachine::resetVolumioState Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreStateMachine::getcurrentVolume Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioRetrievevolume Aug 09 14:34:06 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: Volumio Network Manager: Network status updated: 2 Aug 09 14:34:07 jmjukebox volumio[1040]: verbose: New Socket.io Connection to 192.168.1.190:3000 from 192.168.1.69 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Aug 09 14:34:07 jmjukebox volumio[1040]: verbose: New Socket.io Connection to 192.168.1.190 from 192.168.1.81 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Aug 09 14:34:07 jmjukebox volumio-remote-updater[593]: [2025-08-09 14:34:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1754746446 101 Aug 09 14:34:07 jmjukebox volumio[1040]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:34:07 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:07 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:07 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: VolumeController:: Volume=76 Mute =false Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreStateMachine::pushState Aug 09 14:34:07 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioPushState Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreStateMachine::updateTrackBlock Aug 09 14:34:07 jmjukebox volumio[1040]: info: CorePlayQueue::getTrackBlock Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioRetrievevolume Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreStateMachine::setRepeat null single undefined Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreStateMachine::pushState Aug 09 14:34:07 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioPushState Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreStateMachine::setRandom null Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreStateMachine::pushState Aug 09 14:34:07 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioPushState Aug 09 14:34:07 jmjukebox volumio[1040]: info: Setting Device type: Raspberry PI Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetQueue Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreStateMachine::getQueue Aug 09 14:34:07 jmjukebox volumio[1040]: info: CorePlayQueue::getQueue Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Aug 09 14:34:07 jmjukebox volumio[1040]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Aug 09 14:34:07 jmjukebox volumio[1040]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Aug 09 14:34:07 jmjukebox volumio[1040]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Aug 09 14:34:07 jmjukebox volumio[1040]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Aug 09 14:34:07 jmjukebox volumio[1040]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Aug 09 14:34:07 jmjukebox volumio[1040]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Aug 09 14:34:07 jmjukebox volumio[1040]: verbose: New Socket.io Connection to 192.168.1.190:3000 from 192.168.1.69 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:07 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 09 14:34:07 jmjukebox volumio[1040]: info: Completed loading Core Plugins Aug 09 14:34:07 jmjukebox volumio[1040]: info: Preparing to generate the ALSA configuration file Aug 09 14:34:07 jmjukebox volumio[1040]: info: VolumeController:: Volume=76 Mute =false Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreStateMachine::pushState Aug 09 14:34:07 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioPushState Aug 09 14:34:07 jmjukebox volumio[1040]: info: Discovery: adding 14ba4193-bc2a-4682-a3fe-33b5e39e5dfb Aug 09 14:34:07 jmjukebox volumio[1040]: info: Discovery: Found device JmJukebox Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:07 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 09 14:34:07 jmjukebox volumio[1040]: info: Reading ALSA contributions from plugins. Aug 09 14:34:07 jmjukebox volumio[1040]: info: Asound.conf file unchanged, so no further update is needed Aug 09 14:34:07 jmjukebox volumio[1040]: info: Output device has changed, restarting MPD Aug 09 14:34:07 jmjukebox sudo[1192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 09 14:34:07 jmjukebox volumio[1040]: info: Output device has changed, restarting Shairport Sync Aug 09 14:34:07 jmjukebox sudo[1192]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:07 jmjukebox sudo[1192]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:07 jmjukebox sudo[1194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 09 14:34:07 jmjukebox sudo[1194]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:07 jmjukebox systemd[1]: Stopping Music Player Daemon... Aug 09 14:34:07 jmjukebox volumio[1040]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: ___________ START PLUGINS ___________ Aug 09 14:34:07 jmjukebox volumio[1040]: info: ControllerMpd::onStart: Initializing MPD Aug 09 14:34:07 jmjukebox volumio[1040]: info: Creating MPD Configuration file Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 09 14:34:07 jmjukebox volumio[1040]: info: [1754746447496] CoreMusicLibrary::Adding element Media Servers Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 09 14:34:07 jmjukebox sudo[1203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 09 14:34:07 jmjukebox sudo[1203]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:07 jmjukebox sudo[1201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 09 14:34:07 jmjukebox sudo[1201]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:07 jmjukebox sudo[1201]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:07 jmjukebox systemd[1]: mpd.service: Succeeded. Aug 09 14:34:07 jmjukebox systemd[1]: Stopped Music Player Daemon. Aug 09 14:34:07 jmjukebox volumio[1040]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 09 14:34:07 jmjukebox volumio[1040]: info: [1754746447590] CoreMusicLibrary::Adding element Last_100 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 09 14:34:07 jmjukebox volumio[1040]: info: [1754746447592] CoreMusicLibrary::Adding element Webradio Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 09 14:34:07 jmjukebox volumio[1040]: info: Initializing BBC Radios Aug 09 14:34:07 jmjukebox systemd[1]: Starting Music Player Daemon... Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: Creating Spotify config file Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: Loading i18n strings for locale en Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: FusionDsp - mixtype--------------------- Hardware Aug 09 14:34:07 jmjukebox volumio[1040]: info: Volumio Calling Home Aug 09 14:34:07 jmjukebox sudo[1209]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 09 14:34:07 jmjukebox sudo[1209]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:07 jmjukebox sudo[1209]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:07 jmjukebox volumio[1040]: info: Preparing to generate the ALSA configuration file Aug 09 14:34:07 jmjukebox volumio[1040]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 09 14:34:07 jmjukebox volumio[1040]: info: Reading ALSA contributions from plugins. Aug 09 14:34:07 jmjukebox volumio[1040]: info: MPD Permissions set Aug 09 14:34:07 jmjukebox volumio[1040]: info: MPD Permissions set Aug 09 14:34:07 jmjukebox volumio[1040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:07 jmjukebox volumio[1040]: info: Spotify config file written Aug 09 14:34:07 jmjukebox sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Aug 09 14:34:07 jmjukebox sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:07 jmjukebox volumio[1040]: info: No need to fix Spotify hosts Aug 09 14:34:07 jmjukebox volumio[1040]: info: Volumio called home Aug 09 14:34:07 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:07 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:07 jmjukebox volumio[1040]: info: Starting Shairport Sync Aug 09 14:34:07 jmjukebox volumio[1040]: info: Starting Shairport Sync Aug 09 14:34:07 jmjukebox systemd[1]: Started go-librespot Daemon. Aug 09 14:34:07 jmjukebox go-librespot[1240]: go-librespot daemon starting... Aug 09 14:34:07 jmjukebox sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 09 14:34:07 jmjukebox sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:07 jmjukebox sudo[1238]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:07 jmjukebox volumio[1040]: info: Starting Shairport Sync Aug 09 14:34:08 jmjukebox sudo[1246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 09 14:34:08 jmjukebox systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 09 14:34:08 jmjukebox sudo[1246]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:08 jmjukebox systemd[1]: shairport-sync.service: Succeeded. Aug 09 14:34:08 jmjukebox systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 09 14:34:08 jmjukebox systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 09 14:34:08 jmjukebox sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 09 14:34:08 jmjukebox sudo[1249]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:08 jmjukebox sudo[1242]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:08 jmjukebox systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 09 14:34:08 jmjukebox systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 09 14:34:08 jmjukebox systemd[1]: shairport-sync.service: Succeeded. Aug 09 14:34:08 jmjukebox systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 09 14:34:08 jmjukebox systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 09 14:34:08 jmjukebox volumio[1040]: info: Shairport-Sync Started Aug 09 14:34:08 jmjukebox volumio[1040]: Error adding Membership: Error: addMembership EINVAL Aug 09 14:34:08 jmjukebox volumio[1040]: info: Asound.conf file unchanged, so no further update is needed Aug 09 14:34:08 jmjukebox volumio[1040]: info: Output device has changed, restarting MPD Aug 09 14:34:08 jmjukebox sudo[1246]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:08 jmjukebox sudo[1249]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:08 jmjukebox volumio[1040]: info: Output device has changed, restarting Shairport Sync Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:08 jmjukebox sudo[1259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 09 14:34:08 jmjukebox sudo[1259]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:08 jmjukebox sudo[1259]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:08 jmjukebox sudo[1261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 09 14:34:08 jmjukebox sudo[1261]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:08 jmjukebox volumio[1040]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 09 14:34:08 jmjukebox systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 09 14:34:08 jmjukebox systemd[1]: mpd.service: Succeeded. Aug 09 14:34:08 jmjukebox systemd[1]: Stopped Music Player Daemon. Aug 09 14:34:08 jmjukebox volumio[1040]: info: MPD Permissions set Aug 09 14:34:08 jmjukebox volumio[1040]: info: Shairport-Sync Started Aug 09 14:34:08 jmjukebox volumio[1040]: info: Shairport-Sync Started Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:08 jmjukebox systemd[1]: Starting Music Player Daemon... Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:08 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:08 jmjukebox volumio[1040]: info: Starting Shairport Sync Aug 09 14:34:08 jmjukebox sudo[1275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 09 14:34:08 jmjukebox sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:08 jmjukebox systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 09 14:34:08 jmjukebox systemd[1]: shairport-sync.service: Succeeded. Aug 09 14:34:08 jmjukebox systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 09 14:34:08 jmjukebox systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 09 14:34:08 jmjukebox sudo[1269]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 09 14:34:08 jmjukebox sudo[1269]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:08 jmjukebox sudo[1269]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:08 jmjukebox sudo[1275]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:08 jmjukebox volumio[1040]: info: Shairport-Sync Started Aug 09 14:34:08 jmjukebox go-librespot[1240]: time="2025-08-09T14:34:08+01:00" level=info msg="running go-librespot 0.2.0" Aug 09 14:34:08 jmjukebox go-librespot[1240]: time="2025-08-09T14:34:08+01:00" level=debug msg="app state loaded" Aug 09 14:34:08 jmjukebox go-librespot[1240]: time="2025-08-09T14:34:08+01:00" level=debug msg="stored credentials not found" Aug 09 14:34:08 jmjukebox go-librespot[1240]: time="2025-08-09T14:34:08+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 09 14:34:08 jmjukebox go-librespot[1240]: time="2025-08-09T14:34:08+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 09 14:34:08 jmjukebox go-librespot[1240]: time="2025-08-09T14:34:08+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 09 14:34:08 jmjukebox go-librespot[1240]: time="2025-08-09T14:34:08+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 09 14:34:08 jmjukebox go-librespot[1240]: time="2025-08-09T14:34:08+01:00" level=info msg="zeroconf server listening on port 38477" Aug 09 14:34:08 jmjukebox mpd[1279]: Aug 09 14:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 09 14:34:09 jmjukebox systemd[1]: Started Music Player Daemon. Aug 09 14:34:09 jmjukebox sudo[1261]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:09 jmjukebox sudo[1194]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:09 jmjukebox sudo[1203]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:09 jmjukebox volumio[1040]: info: Completed starting Core Plugins Aug 09 14:34:09 jmjukebox volumio[1040]: info: ------------------------------------------- Aug 09 14:34:09 jmjukebox volumio[1040]: info: ----- MyVolumio plugins startup ---- Aug 09 14:34:09 jmjukebox volumio[1040]: info: ------------------------------------------- Aug 09 14:34:09 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 09 14:34:09 jmjukebox volumio[1040]: error: MPD error: The expression evaluated to a falsy value: Aug 09 14:34:09 jmjukebox volumio[1040]: assert.ok(self.idling) Aug 09 14:34:09 jmjukebox volumio[1040]: error: The expression evaluated to a falsy value: Aug 09 14:34:09 jmjukebox volumio[1040]: assert.ok(self.idling) Aug 09 14:34:09 jmjukebox volumio[1040]: info: MPD running with PID1279 Aug 09 14:34:09 jmjukebox volumio[1040]: ,establishing connection Aug 09 14:34:09 jmjukebox volumio[1040]: error: MPD error: The expression evaluated to a falsy value: Aug 09 14:34:09 jmjukebox volumio[1040]: assert.ok(self.idling) Aug 09 14:34:09 jmjukebox volumio[1040]: error: The expression evaluated to a falsy value: Aug 09 14:34:09 jmjukebox volumio[1040]: assert.ok(self.idling) Aug 09 14:34:09 jmjukebox volumio[1040]: error: MPD error: The expression evaluated to a falsy value: Aug 09 14:34:09 jmjukebox volumio[1040]: assert.ok(self.idling) Aug 09 14:34:09 jmjukebox volumio[1040]: error: The expression evaluated to a falsy value: Aug 09 14:34:09 jmjukebox volumio[1040]: assert.ok(self.idling) Aug 09 14:34:09 jmjukebox volumio[1040]: error: updateQueue error: null Aug 09 14:34:09 jmjukebox volumio[1040]: info: camilladsp service started and running in background, instance 1 Aug 09 14:34:09 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:09 jmjukebox volumio[1040]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 <-AAAAAAAAAAAAA Aug 09 14:34:09 jmjukebox volumio[1040]: info: FusionDsp loaded Aug 09 14:34:09 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:34:09 jmjukebox sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 09 14:34:09 jmjukebox sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:09 jmjukebox volumio[1040]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 09 14:34:09 jmjukebox volumio[1040]: info: Adding Signal Path Element [object Object] Aug 09 14:34:09 jmjukebox volumio[1040]: info: Adding fusiondspeq DSP Signal Path Element Aug 09 14:34:09 jmjukebox volumio[1040]: info: FusionDsp - ---- installed callbackRead Aug 09 14:34:09 jmjukebox volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 09 14:34:09 jmjukebox volumio[1040]: error: FusionDsp - WebSocket error: [object Object] Aug 09 14:34:09 jmjukebox volumio[1040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 09 14:34:09 jmjukebox systemd[1]: Started FusionDsp Daemon. Aug 09 14:34:09 jmjukebox sudo[1298]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:10 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:34:10 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:34:10 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:34:10 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:10 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:10 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:34:11 jmjukebox volumio[1040]: info: go-librespot daemon successfully initialized Aug 09 14:34:13 jmjukebox sudo[1322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 09 14:34:13 jmjukebox sudo[1322]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:13 jmjukebox sudo[1322]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:13 jmjukebox sudo[1324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 09 14:34:13 jmjukebox sudo[1324]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:13 jmjukebox sudo[1324]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:13 jmjukebox sudo[1328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 09 14:34:13 jmjukebox sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:14 jmjukebox systemd[1]: Started UPnP Renderer front-end to MPD. Aug 09 14:34:14 jmjukebox sudo[1328]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:14 jmjukebox volumio[1040]: info: Upmpdcli Daemon Started Aug 09 14:34:14 jmjukebox volumio[1040]: info: Initializing connection to go-librespot Websocket Aug 09 14:34:14 jmjukebox go-librespot[1240]: time="2025-08-09T14:34:14+01:00" level=debug msg="new websocket client" Aug 09 14:34:14 jmjukebox volumio[1330]: Generating RSA private key, 4096 bit long modulus (2 primes) Aug 09 14:34:14 jmjukebox volumio[1040]: info: Connection to go-librespot Websocket established Aug 09 14:34:17 jmjukebox volumio[1040]: info: Getting Spotify volume Aug 09 14:34:17 jmjukebox volumio[1040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Aug 09 14:34:17 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:17 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:17 jmjukebox volumio[1040]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Aug 09 14:34:17 jmjukebox volumio[1040]: SPOTIFY: SPOTIFY VOLUME undefined Aug 09 14:34:17 jmjukebox volumio[1040]: SPOTIFY: VOLUMIO VOLUME 76 Aug 09 14:34:17 jmjukebox volumio[1040]: info: Aligning Spotify Volume to Volumio Volume Aug 09 14:34:17 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:17 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:17 jmjukebox volumio[1040]: info: Setting Spotify Volume from Volumio: 76 Aug 09 14:34:17 jmjukebox sudo[1350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 09 14:34:17 jmjukebox sudo[1350]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:17 jmjukebox sudo[1350]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:17 jmjukebox sudo[1353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 09 14:34:17 jmjukebox sudo[1353]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:17 jmjukebox sudo[1353]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:17 jmjukebox volumio[1040]: verbose: New Socket.io Connection to 192.168.1.190 from 192.168.1.81 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 09 14:34:17 jmjukebox sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 09 14:34:17 jmjukebox sudo[1356]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:17 jmjukebox sudo[1356]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:17 jmjukebox sudo[1359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 09 14:34:17 jmjukebox sudo[1359]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 09 14:34:17 jmjukebox sudo[1359]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 09 14:34:17 jmjukebox volumio[1040]: info: Adding plugin bluetooth to MyMusic Plugins Aug 09 14:34:17 jmjukebox volumio[1040]: info: Adding plugin multiroom to MyMusic Plugins Aug 09 14:34:17 jmjukebox volumio[1040]: info: Adding plugin metavolumio to MyMusic Plugins Aug 09 14:34:17 jmjukebox volumio[1040]: info: Adding plugin cd_controller to MyMusic Plugins Aug 09 14:34:17 jmjukebox volumio[1040]: info: Adding plugin qobuzconnect to MyMusic Plugins Aug 09 14:34:17 jmjukebox volumio[1040]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 09 14:34:17 jmjukebox volumio[1040]: info: Adding plugin tidalconnect to MyMusic Plugins Aug 09 14:34:17 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 09 14:34:18 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 09 14:34:18 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 09 14:34:18 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:18 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:18 jmjukebox volumio[1040]: info: Starting MyVolumio Remote Streaming Endpoints Aug 09 14:34:18 jmjukebox volumio[1040]: info: MyVolumio login type: Token Aug 09 14:34:18 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 09 14:34:18 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 09 14:34:19 jmjukebox volumio[1040]: info: Starting Streaming Service Transparent Proxy Aug 09 14:34:19 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 09 14:34:19 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 09 14:34:19 jmjukebox volumio[1040]: info: Streaming services startup Aug 09 14:34:19 jmjukebox volumio[1040]: info: Starting Streaming Daemon Aug 09 14:34:19 jmjukebox sudo[1368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 09 14:34:19 jmjukebox sudo[1368]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:19 jmjukebox sudo[1368]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:19 jmjukebox volumio[1040]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Aug 09 14:34:19 jmjukebox volumio[1040]: SPOTIFY: SETTING SPOTIFY VOLUME 76 Aug 09 14:34:19 jmjukebox volumio[1040]: info: Sending Spotify command with payload to local API: /player/volume Aug 09 14:34:19 jmjukebox volumio[1040]: error: Cannot start Volumio Streaming Daemon Aug 09 14:34:19 jmjukebox volumio[1040]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 09 14:34:19 jmjukebox volumio[1040]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 09 14:34:19 jmjukebox volumio[1040]: verbose: New Socket.io Connection to 192.168.1.190 from 192.168.1.81 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetVisibleSources Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:19 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 09 14:34:19 jmjukebox volumio[1040]: info: Received Get System Info Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:34:19 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:19 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:19 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:19 jmjukebox volumio[1040]: info: Listing playlists Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 09 14:34:19 jmjukebox volumio[1040]: info: Received Get System Info Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:34:19 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:19 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:34:19 jmjukebox volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 09 14:34:19 jmjukebox volumio[1040]: info: FusionDsp - jmo test Aug 09 14:34:19 jmjukebox volumio[1040]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,jmo test.json Aug 09 14:34:20 jmjukebox volumio[1040]: STREAMING PROXY: Starting server on port 3245 Aug 09 14:34:20 jmjukebox volumio[1040]: Node JS runtime: 14 Aug 09 14:34:20 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 09 14:34:20 jmjukebox volumio[1040]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Aug 09 14:34:20 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Aug 09 14:34:20 jmjukebox volumio[1040]: info: MyVolumio login type: Token Aug 09 14:34:20 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:20 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:20 jmjukebox volumio[1040]: info: MyVolumio token set successfully Aug 09 14:34:20 jmjukebox volumio[1040]: info: MYVOLUMIO: Adding device Aug 09 14:34:20 jmjukebox volumio[1040]: info: MYVOLUMIO: Evaluating Server Aug 09 14:34:21 jmjukebox volumio[1040]: info: MyVolumio status changed Aug 09 14:34:21 jmjukebox volumio[1040]: info: Streaming services startup Aug 09 14:34:21 jmjukebox volumio[1040]: info: Starting Streaming Daemon Aug 09 14:34:21 jmjukebox volumio[1040]: info: Removing browser output: myVolumio user plan is not superstar Aug 09 14:34:21 jmjukebox volumio[1040]: info: Removing audio output: Aug 09 14:34:21 jmjukebox volumio[1040]: info: Stoppping Tunnel 1 Aug 09 14:34:21 jmjukebox sudo[1393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 09 14:34:21 jmjukebox sudo[1393]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:21 jmjukebox sudo[1393]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:21 jmjukebox sudo[1396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Aug 09 14:34:21 jmjukebox sudo[1396]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:34:21 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 09 14:34:21 jmjukebox sudo[1396]: pam_unix(sudo:session): session closed for user root Aug 09 14:34:21 jmjukebox volumio[1040]: info: Remote SSH Stopped Aug 09 14:34:21 jmjukebox volumio[1040]: error: Cannot start Volumio Streaming Daemon Aug 09 14:34:21 jmjukebox volumio[1040]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 09 14:34:21 jmjukebox volumio[1040]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 09 14:34:21 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 09 14:34:21 jmjukebox volumio[1040]: info: Received Get System Info Aug 09 14:34:21 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:34:21 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:34:21 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:34:21 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:21 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:21 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:34:21 jmjukebox volumio[1040]: info: Setting Geolocation for MyVolumio to eu3 Aug 09 14:34:21 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:21 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:21 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:21 jmjukebox volumio[1040]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Aug 09 14:34:22 jmjukebox volumio[1040]: info: Updating MyVolumio device info Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 09 14:34:22 jmjukebox volumio[1040]: info: Received Get System Info Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:34:22 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:22 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:22 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:34:22 jmjukebox volumio[1040]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Aug 09 14:34:25 jmjukebox volumio[1040]: info: MYVOLUMIO: Adding device Aug 09 14:34:25 jmjukebox volumio[1040]: info: MYVOLUMIO: Evaluating Server Aug 09 14:34:26 jmjukebox volumio[1040]: info: Setting Geolocation for MyVolumio to eu3 Aug 09 14:34:26 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:26 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:26 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:27 jmjukebox volumio[1040]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Aug 09 14:34:27 jmjukebox volumio[1040]: info: Updating MyVolumio device info Aug 09 14:34:27 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:27 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:27 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:28 jmjukebox volumio[1040]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Aug 09 14:34:28 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:28 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:29 jmjukebox systemd[1]: systemd-timedated.service: Succeeded. Aug 09 14:34:30 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 09 14:34:33 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 09 14:34:33 jmjukebox volumio[1040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Aug 09 14:34:33 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:33 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:36 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 09 14:34:36 jmjukebox volumio[1040]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 09 14:34:36 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 09 14:34:36 jmjukebox volumio[1040]: info: Received Get System Version Aug 09 14:34:36 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 09 14:34:36 jmjukebox volumio[1040]: info: Received Get System Info Aug 09 14:34:36 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:34:36 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:34:36 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:34:36 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:36 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:36 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:34:37 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 09 14:34:37 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:37 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 09 14:34:37 jmjukebox volumio-remote-updater[593]: No test mode Aug 09 14:34:37 jmjukebox volumio-remote-updater[593]: No alpha test mode Aug 09 14:34:37 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 09 14:34:37 jmjukebox volumio[1040]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 09 14:34:37 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 09 14:34:38 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:38 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:38 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 09 14:34:38 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 09 14:34:38 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 09 14:34:38 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetBrowseSources Aug 09 14:34:38 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 09 14:34:38 jmjukebox ntpd[763]: Soliciting pool server 194.117.47.42 Aug 09 14:34:39 jmjukebox volumio[1040]: error: MyVolumio Plugin failed to authenticate in a timely fashion Aug 09 14:34:39 jmjukebox volumio[1040]: info: Completed starting MyVolumio Plugin Aug 09 14:34:39 jmjukebox volumio[1040]: [Metrics] CommandRouter: 38s 711.21ms Aug 09 14:34:39 jmjukebox volumio[1040]: info: CoreCommandRouter::volumiosetStartupVolume Aug 09 14:34:39 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 09 14:34:39 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 09 14:34:39 jmjukebox volumio[1040]: info: CoreCommandRouter::Close All Modals sent Aug 09 14:34:39 jmjukebox volumio[1040]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Aug 09 14:34:39 jmjukebox volumio[1040]: info: FusionDsp - ---- read samplerate from file: 44100 Aug 09 14:34:39 jmjukebox volumio[1040]: info: camilladsp stopping service pid 1294... Aug 09 14:34:39 jmjukebox kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=-11) Aug 09 14:34:39 jmjukebox volumio[1040]: info: camilladsp service terminated, instance 1 Aug 09 14:34:39 jmjukebox volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 09 14:34:39 jmjukebox volumio[1040]: info: camilladsp service started and running in background, instance 1 Aug 09 14:34:39 jmjukebox ntpd[763]: Soliciting pool server 162.159.200.1 Aug 09 14:34:40 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 09 14:34:40 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 09 14:34:40 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 09 14:34:40 jmjukebox ntpd[763]: Soliciting pool server 91.209.16.78 Aug 09 14:34:40 jmjukebox ntpd[763]: Soliciting pool server 193.136.164.4 Aug 09 14:34:40 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:34:40 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:34:40 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:34:40 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:34:40 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:34:40 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:34:41 jmjukebox ntpd[763]: Soliciting pool server 23.147.168.132 Aug 09 14:34:41 jmjukebox ntpd[763]: Soliciting pool server 81.193.254.213 Aug 09 14:34:42 jmjukebox ntpd[763]: Soliciting pool server 23.147.168.175 Aug 09 14:34:42 jmjukebox ntpd[763]: Soliciting pool server 23.147.168.175 Aug 09 14:34:42 jmjukebox ntpd[763]: Soliciting pool server 185.228.163.139 Aug 09 14:34:43 jmjukebox ntpd[763]: Soliciting pool server 23.147.168.176 Aug 09 14:34:43 jmjukebox ntpd[763]: Soliciting pool server 162.159.200.123 Aug 09 14:34:44 jmjukebox kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=-11) Aug 09 14:34:44 jmjukebox volumio[1330]: ........................................................................................................................................................................................................................................................................................................................................................++++ Aug 09 14:34:45 jmjukebox volumio[1330]: .......++++ Aug 09 14:34:45 jmjukebox volumio[1330]: e is 65537 (0x010001) Aug 09 14:34:45 jmjukebox volumio[1330]: writing RSA key Aug 09 14:34:46 jmjukebox volumio[1040]: info: BOOT COMPLETED Aug 09 14:34:48 jmjukebox ntpd[763]: receive: Unexpected origin timestamp 0xec41ccf7.d437c40e does not match aorg 0000000000.00000000 from server@193.136.164.4 xmt 0xec41ccf8.eb424dfc Aug 09 14:34:51 jmjukebox kernel: usb 1-1.4: new full-speed USB device number 3 using xhci_hcd Aug 09 14:34:51 jmjukebox kernel: usb 1-1.4: config 1 has an invalid interface number: 3 but max is 2 Aug 09 14:34:51 jmjukebox kernel: usb 1-1.4: config 1 has an invalid interface number: 3 but max is 2 Aug 09 14:34:51 jmjukebox kernel: usb 1-1.4: config 1 has an invalid interface number: 3 but max is 2 Aug 09 14:34:51 jmjukebox kernel: usb 1-1.4: config 1 has an invalid interface number: 3 but max is 2 Aug 09 14:34:51 jmjukebox kernel: usb 1-1.4: config 1 has no interface number 2 Aug 09 14:34:51 jmjukebox kernel: usb 1-1.4: New USB device found, idVendor=262a, idProduct=9023, bcdDevice= 0.01 Aug 09 14:34:51 jmjukebox kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Aug 09 14:34:51 jmjukebox kernel: usb 1-1.4: Product: Digital Hifi Audio Aug 09 14:34:51 jmjukebox kernel: usb 1-1.4: Manufacturer: Digital Hifi Audio Aug 09 14:34:51 jmjukebox kernel: hid-generic 0003:262A:9023.0001: No inputs registered, leaving Aug 09 14:34:51 jmjukebox kernel: hid-generic 0003:262A:9023.0001: hidraw0: USB HID v1.00 Device [Digital Hifi Audio Digital Hifi Audio] on usb-0000:01:00.0-1.4/input0 Aug 09 14:34:51 jmjukebox kernel: usbcore: registered new interface driver snd-usb-audio Aug 09 14:34:51 jmjukebox volumio[1040]: info: Aug 09 14:34:51 jmjukebox volumio[1040]: ---------------------------- USB Audio Device Attached Aug 09 14:34:51 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Aug 09 14:35:03 jmjukebox volumio[1040]: verbose: New Socket.io Connection to 192.168.1.190 from 192.168.1.81 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 09 14:35:03 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:35:03 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:35:03 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetQueue Aug 09 14:35:03 jmjukebox volumio[1040]: info: CoreStateMachine::getQueue Aug 09 14:35:03 jmjukebox volumio[1040]: info: CorePlayQueue::getQueue Aug 09 14:35:03 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Aug 09 14:35:03 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Aug 09 14:35:03 jmjukebox volumio[1040]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Aug 09 14:35:03 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Aug 09 14:35:03 jmjukebox volumio[1040]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Aug 09 14:35:03 jmjukebox volumio[1040]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Aug 09 14:35:03 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Aug 09 14:35:11 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:35:11 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:35:11 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:35:11 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:35:11 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:35:11 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:35:27 jmjukebox volumio[1040]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Aug 09 14:35:27 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Aug 09 14:35:27 jmjukebox sudo[1639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig Aug 09 14:35:27 jmjukebox sudo[1639]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:35:27 jmjukebox sudo[1639]: pam_unix(sudo:session): session closed for user root Aug 09 14:35:31 jmjukebox sudo[1703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Aug 09 14:35:31 jmjukebox sudo[1703]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:35:31 jmjukebox sudo[1703]: pam_unix(sudo:session): session closed for user root Aug 09 14:35:31 jmjukebox volumio[1040]: info: Log sent successfully, reply: {"status":"OK","link":"http://logs.volumio.org/volumio/ola6FAD.html"} Aug 09 14:35:41 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:35:41 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:35:41 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:35:41 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:35:41 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:35:41 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:36:12 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:36:12 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:36:12 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:36:12 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:36:12 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:36:12 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:36:41 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 09 14:36:41 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 09 14:36:41 jmjukebox volumio[1040]: info: Discovery: Getting this device information Aug 09 14:36:41 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:36:41 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:36:41 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 09 14:36:51 jmjukebox volumio[1040]: verbose: New Socket.io Connection to 192.168.1.190 from 192.168.1.81 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 09 14:36:51 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetState Aug 09 14:36:51 jmjukebox volumio[1040]: info: CorePlayQueue::getTrack 0 Aug 09 14:36:51 jmjukebox volumio[1040]: info: CoreCommandRouter::volumioGetQueue Aug 09 14:36:51 jmjukebox volumio[1040]: info: CoreStateMachine::getQueue Aug 09 14:36:51 jmjukebox volumio[1040]: info: CorePlayQueue::getQueue Aug 09 14:36:51 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Aug 09 14:36:51 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Aug 09 14:36:51 jmjukebox volumio[1040]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Aug 09 14:36:51 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Aug 09 14:36:51 jmjukebox volumio[1040]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Aug 09 14:36:51 jmjukebox volumio[1040]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Aug 09 14:36:51 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Aug 09 14:37:00 jmjukebox volumio[1040]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Aug 09 14:37:00 jmjukebox volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Aug 09 14:37:00 jmjukebox sudo[1962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig Aug 09 14:37:00 jmjukebox sudo[1962]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 09 14:37:00 jmjukebox sudo[1962]: pam_unix(sudo:session): session closed for user root Aug 09 14:37:03 jmjukebox sudo[2023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Aug 09 14:37:03 jmjukebox sudo[2023]: pam_unix(sudo:session): session opened for user root by (uid=0)