Tue Jan 30 18:32:29 CET 2024
Description="'NAS showing NaN MB after update to 3.601'"
# cat /proc/version ---------------
Linux version 6.1.70-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1712 SMP Tue Jan 2 18:29:06 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="e5e6090399db628f1586eb4951e3592507f5fd38"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="50b5825b3acc4c58b5033699bcdbbd219d6a0836"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 19 Jan 2024 06:17:59 PM CET"
VOLUMIO_VERSION="3.601"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="36b9da4b4411039910a860c6fa7331da"
# ifconfig ---------------
eth0: flags=4099 mtu 1500
ether dc:a6:32:6c:7a:fc txqueuelen 1000 (Ethernet)
RX packets 0 bytes 0 (0.0 B)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 0 bytes 0 (0.0 B)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
lo: flags=73 mtu 65536
inet 127.0.0.1 netmask 255.0.0.0
loop txqueuelen 1000 (Local Loopback)
RX packets 1220 bytes 492863 (481.3 KiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 1220 bytes 492863 (481.3 KiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
wlan0: flags=4163 mtu 1500
inet 192.168.178.227 netmask 255.255.255.0 broadcast 192.168.178.255
ether dc:a6:32:6c:7a:fd txqueuelen 1000 (Ethernet)
RX packets 3586 bytes 1439189 (1.3 MiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 2504 bytes 486343 (474.9 KiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
# sudo iwconfig ---------------
lo no wireless extensions.
eth0 no wireless extensions.
wlan0 IEEE 802.11 ESSID:"Ziggy"
Mode:Managed Frequency:5.24 GHz Access Point: AC:22:05:46:79:F1
Bit Rate=325 Mb/s Tx-Power=31 dBm
Retry short limit:7 RTS thr:off Fragment thr:off
Encryption key:off
Power Management:off
Link Quality=50/70 Signal level=-60 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: Headphones [bcm2835 Headphones], device 0: bcm2835 Headphones [bcm2835 Headphones]
Subdevices: 8/8
Subdevice #0: subdevice #0
Subdevice #1: subdevice #1
Subdevice #2: subdevice #2
Subdevice #3: subdevice #3
Subdevice #4: subdevice #4
Subdevice #5: subdevice #5
Subdevice #6: subdevice #6
Subdevice #7: subdevice #7
card 5: D10s [D10s], device 0: USB Audio [USB Audio]
Subdevices: 1/1
Subdevice #0: subdevice #0
# lsusb ---------------
Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 001 Device 003: ID 152a:8750 Thesycon Systemsoftware & Consulting GmbH
Bus 001 Device 002: ID 2109:3431 VIA Labs, Inc. Hub
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
# lsusb -t ---------------
/: Bus 02.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/4p, 5000M
/: Bus 01.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/1p, 480M
|__ Port 1: Dev 2, If 0, Class=Hub, Driver=hub/4p, 480M
|__ Port 2: Dev 3, If 0, Class=Audio, Driver=snd-usb-audio, 480M
|__ Port 2: Dev 3, If 1, Class=Audio, Driver=snd-usb-audio, 480M
|__ Port 2: Dev 3, If 2, Class=Application Specific Interface, Driver=, 480M
# lsusb -v ---------------
Couldn't open device, some information will be missing
Couldn't open device, some information will be missing
Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 3.00
bDeviceClass 9 Hub
bDeviceSubClass 0
bDeviceProtocol 3
bMaxPacketSize0 9
idVendor 0x1d6b Linux Foundation
idProduct 0x0003 3.0 root hub
bcdDevice 6.01
iManufacturer 3
iProduct 2
iSerial 1
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 0x001f
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0xe0
Self Powered
Remote Wakeup
MaxPower 0mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 1
bInterfaceClass 9 Hub
bInterfaceSubClass 0
bInterfaceProtocol 0 Full speed (or root) hub
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0004 1x 4 bytes
bInterval 12
bMaxBurst 0
Bus 001 Device 003: ID 152a:8750 Thesycon Systemsoftware & Consulting GmbH
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.00
bDeviceClass 239 Miscellaneous Device
bDeviceSubClass 2
bDeviceProtocol 1 Interface Association
bMaxPacketSize0 64
idVendor 0x152a Thesycon Systemsoftware & Consulting GmbH
idProduct 0x8750
bcdDevice 1.04
iManufacturer 1
iProduct 3
iSerial 0
bNumConfigurations 2
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 0x011c
bNumInterfaces 3
bConfigurationValue 1
iConfiguration 0
bmAttributes 0x80
(Bus Powered)
MaxPower 0mA
Interface Association:
bLength 8
bDescriptorType 11
bFirstInterface 0
bInterfaceCount 2
bFunctionClass 1 Audio
bFunctionSubClass 0
bFunctionProtocol 32
iFunction 0
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 0
bInterfaceClass 1 Audio
bInterfaceSubClass 1 Control Device
bInterfaceProtocol 32
iInterface 3
AudioControl Interface Descriptor:
bLength 9
bDescriptorType 36
bDescriptorSubtype 1 (HEADER)
bcdADC 2.00
bCategory 8
wTotalLength 0x0048
bmControls 0x00
AudioControl Interface Descriptor:
bLength 8
bDescriptorType 36
bDescriptorSubtype 10 (CLOCK_SOURCE)
bClockID 41
bmAttributes 3 Internal programmable clock
bmControls 0x07
Clock Frequency Control (read/write)
Clock Validity Control (read-only)
bAssocTerminal 0
iClockSource 9
AudioControl Interface Descriptor:
bLength 8
bDescriptorType 36
bDescriptorSubtype 11 (CLOCK_SELECTOR)
bClockID 40
bNrInPins 1
baCSourceID(0) 41
bmControls 0x03
Clock Selector Control (read/write)
iClockSelector 8
AudioControl Interface Descriptor:
bLength 17
bDescriptorType 36
bDescriptorSubtype 2 (INPUT_TERMINAL)
bTerminalID 2
wTerminalType 0x0101 USB Streaming
bAssocTerminal 0
bCSourceID 40
bNrChannels 2
bmChannelConfig 0x00000000
iChannelNames 11
bmControls 0x0000
iTerminal 6
AudioControl Interface Descriptor:
bLength 18
bDescriptorType 36
bDescriptorSubtype 6 (FEATURE_UNIT)
bUnitID 10
bSourceID 2
bmaControls(0) 0x0000000f
Mute Control (read/write)
Volume Control (read/write)
bmaControls(1) 0x00000000
bmaControls(2) 0x00000000
iFeature 0
AudioControl Interface Descriptor:
bLength 12
bDescriptorType 36
bDescriptorSubtype 3 (OUTPUT_TERMINAL)
bTerminalID 20
wTerminalType 0x0301 Speaker
bAssocTerminal 0
bSourceID 10
bCSourceID 40
bmControls 0x0000
iTerminal 0
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 0
bNumEndpoints 0
bInterfaceClass 1 Audio
bInterfaceSubClass 2 Streaming
bInterfaceProtocol 32
iInterface 4
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 1
bNumEndpoints 2
bInterfaceClass 1 Audio
bInterfaceSubClass 2 Streaming
bInterfaceProtocol 32
iInterface 4
AudioStreaming Interface Descriptor:
bLength 16
bDescriptorType 36
bDescriptorSubtype 1 (AS_GENERAL)
bTerminalLink 2
bmControls 0x00
bFormatType 1
bmFormats 0x00000001
PCM
bNrChannels 2
bmChannelConfig 0x00000000
iChannelNames 11
AudioStreaming Interface Descriptor:
bLength 6
bDescriptorType 36
bDescriptorSubtype 2 (FORMAT_TYPE)
bFormatType 1 (FORMAT_TYPE_I)
bSubslotSize 4
bBitResolution 32
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x01 EP 1 OUT
bmAttributes 5
Transfer Type Isochronous
Synch Type Asynchronous
Usage Type Data
wMaxPacketSize 0x0188 1x 392 bytes
bInterval 1
AudioStreaming Endpoint Descriptor:
bLength 8
bDescriptorType 37
bDescriptorSubtype 1 (EP_GENERAL)
bmAttributes 0x00
bmControls 0x00
bLockDelayUnits 2 Decoded PCM samples
wLockDelay 0x0008
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 17
Transfer Type Isochronous
Synch Type None
Usage Type Feedback
wMaxPacketSize 0x0004 1x 4 bytes
bInterval 4
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 2
bNumEndpoints 2
bInterfaceClass 1 Audio
bInterfaceSubClass 2 Streaming
bInterfaceProtocol 32
iInterface 4
AudioStreaming Interface Descriptor:
bLength 16
bDescriptorType 36
bDescriptorSubtype 1 (AS_GENERAL)
bTerminalLink 2
bmControls 0x00
bFormatType 1
bmFormats 0x00000001
PCM
bNrChannels 2
bmChannelConfig 0x00000000
iChannelNames 11
AudioStreaming Interface Descriptor:
bLength 6
bDescriptorType 36
bDescriptorSubtype 2 (FORMAT_TYPE)
bFormatType 1 (FORMAT_TYPE_I)
bSubslotSize 4
bBitResolution 24
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x01 EP 1 OUT
bmAttributes 5
Transfer Type Isochronous
Synch Type Asynchronous
Usage Type Data
wMaxPacketSize 0x0188 1x 392 bytes
bInterval 1
AudioStreaming Endpoint Descriptor:
bLength 8
bDescriptorType 37
bDescriptorSubtype 1 (EP_GENERAL)
bmAttributes 0x00
bmControls 0x00
bLockDelayUnits 2 Decoded PCM samples
wLockDelay 0x0008
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 17
Transfer Type Isochronous
Synch Type None
Usage Type Feedback
wMaxPacketSize 0x0004 1x 4 bytes
bInterval 4
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 3
bNumEndpoints 2
bInterfaceClass 1 Audio
bInterfaceSubClass 2 Streaming
bInterfaceProtocol 32
iInterface 4
AudioStreaming Interface Descriptor:
bLength 16
bDescriptorType 36
bDescriptorSubtype 1 (AS_GENERAL)
bTerminalLink 2
bmControls 0x00
bFormatType 1
bmFormats 0x80000000
bNrChannels 2
bmChannelConfig 0x00000000
iChannelNames 11
AudioStreaming Interface Descriptor:
bLength 6
bDescriptorType 36
bDescriptorSubtype 2 (FORMAT_TYPE)
bFormatType 1 (FORMAT_TYPE_I)
bSubslotSize 4
bBitResolution 32
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x01 EP 1 OUT
bmAttributes 5
Transfer Type Isochronous
Synch Type Asynchronous
Usage Type Data
wMaxPacketSize 0x0188 1x 392 bytes
bInterval 1
AudioStreaming Endpoint Descriptor:
bLength 8
bDescriptorType 37
bDescriptorSubtype 1 (EP_GENERAL)
bmAttributes 0x00
bmControls 0x00
bLockDelayUnits 2 Decoded PCM samples
wLockDelay 0x0008
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 17
Transfer Type Isochronous
Synch Type None
Usage Type Feedback
wMaxPacketSize 0x0004 1x 4 bytes
bInterval 4
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 2
bAlternateSetting 0
bNumEndpoints 0
bInterfaceClass 254 Application Specific Interface
bInterfaceSubClass 1 Device Firmware Update
bInterfaceProtocol 1
iInterface 10
Device Firmware Upgrade Interface Descriptor:
bLength 9
bDescriptorType 33
bmAttributes 7
Will Not Detach
Manifestation Tolerant
Upload Supported
Download Supported
wDetachTimeout 250 milliseconds
wTransferSize 64 bytes
bcdDFUVersion 1.10
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 0x011c
bNumInterfaces 3
bConfigurationValue 1
iConfiguration 0
bmAttributes 0x80
(Bus Powered)
MaxPower 0mA
Interface Association:
bLength 8
bDescriptorType 11
bFirstInterface 0
bInterfaceCount 2
bFunctionClass 1 Audio
bFunctionSubClass 0
bFunctionProtocol 32
iFunction 0
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 0
bInterfaceClass 1 Audio
bInterfaceSubClass 1 Control Device
bInterfaceProtocol 32
iInterface 3
AudioControl Interface Descriptor:
bLength 9
bDescriptorType 36
bDescriptorSubtype 1 (HEADER)
bcdADC 2.00
bCategory 8
wTotalLength 0x0048
bmControls 0x00
AudioControl Interface Descriptor:
bLength 8
bDescriptorType 36
bDescriptorSubtype 10 (CLOCK_SOURCE)
bClockID 41
bmAttributes 3 Internal programmable clock
bmControls 0x07
Clock Frequency Control (read/write)
Clock Validity Control (read-only)
bAssocTerminal 0
iClockSource 9
AudioControl Interface Descriptor:
bLength 8
bDescriptorType 36
bDescriptorSubtype 11 (CLOCK_SELECTOR)
bClockID 40
bNrInPins 1
baCSourceID(0) 41
bmControls 0x03
Clock Selector Control (read/write)
iClockSelector 8
AudioControl Interface Descriptor:
bLength 17
bDescriptorType 36
bDescriptorSubtype 2 (INPUT_TERMINAL)
bTerminalID 2
wTerminalType 0x0101 USB Streaming
bAssocTerminal 0
bCSourceID 40
bNrChannels 2
bmChannelConfig 0x00000000
iChannelNames 11
bmControls 0x0000
iTerminal 6
AudioControl Interface Descriptor:
bLength 18
bDescriptorType 36
bDescriptorSubtype 6 (FEATURE_UNIT)
bUnitID 10
bSourceID 2
bmaControls(0) 0x0000000f
Mute Control (read/write)
Volume Control (read/write)
bmaControls(1) 0x00000000
bmaControls(2) 0x00000000
iFeature 0
AudioControl Interface Descriptor:
bLength 12
bDescriptorType 36
bDescriptorSubtype 3 (OUTPUT_TERMINAL)
bTerminalID 20
wTerminalType 0x0301 Speaker
bAssocTerminal 0
bSourceID 10
bCSourceID 40
bmControls 0x0000
iTerminal 0
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 0
bNumEndpoints 0
bInterfaceClass 1 Audio
bInterfaceSubClass 2 Streaming
bInterfaceProtocol 32
iInterface 4
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 1
bNumEndpoints 2
bInterfaceClass 1 Audio
bInterfaceSubClass 2 Streaming
bInterfaceProtocol 32
iInterface 4
AudioStreaming Interface Descriptor:
bLength 16
bDescriptorType 36
bDescriptorSubtype 1 (AS_GENERAL)
bTerminalLink 2
bmControls 0x00
bFormatType 1
bmFormats 0x00000001
PCM
bNrChannels 2
bmChannelConfig 0x00000000
iChannelNames 11
AudioStreaming Interface Descriptor:
bLength 6
bDescriptorType 36
bDescriptorSubtype 2 (FORMAT_TYPE)
bFormatType 1 (FORMAT_TYPE_I)
bSubslotSize 4
bBitResolution 32
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x01 EP 1 OUT
bmAttributes 5
Transfer Type Isochronous
Synch Type Asynchronous
Usage Type Data
wMaxPacketSize 0x0188 1x 392 bytes
bInterval 1
AudioStreaming Endpoint Descriptor:
bLength 8
bDescriptorType 37
bDescriptorSubtype 1 (EP_GENERAL)
bmAttributes 0x00
bmControls 0x00
bLockDelayUnits 2 Decoded PCM samples
wLockDelay 0x0008
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 17
Transfer Type Isochronous
Synch Type None
Usage Type Feedback
wMaxPacketSize 0x0004 1x 4 bytes
bInterval 4
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 2
bNumEndpoints 2
bInterfaceClass 1 Audio
bInterfaceSubClass 2 Streaming
bInterfaceProtocol 32
iInterface 4
AudioStreaming Interface Descriptor:
bLength 16
bDescriptorType 36
bDescriptorSubtype 1 (AS_GENERAL)
bTerminalLink 2
bmControls 0x00
bFormatType 1
bmFormats 0x00000001
PCM
bNrChannels 2
bmChannelConfig 0x00000000
iChannelNames 11
AudioStreaming Interface Descriptor:
bLength 6
bDescriptorType 36
bDescriptorSubtype 2 (FORMAT_TYPE)
bFormatType 1 (FORMAT_TYPE_I)
bSubslotSize 4
bBitResolution 24
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x01 EP 1 OUT
bmAttributes 5
Transfer Type Isochronous
Synch Type Asynchronous
Usage Type Data
wMaxPacketSize 0x0188 1x 392 bytes
bInterval 1
AudioStreaming Endpoint Descriptor:
bLength 8
bDescriptorType 37
bDescriptorSubtype Couldn't open device, some information will be missing
1 (EP_GENERAL)
bmAttributes 0x00
bmControls 0x00
bLockDelayUnits 2 Decoded PCM samples
wLockDelay 0x0008
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 17
Transfer Type Isochronous
Synch Type None
Usage Type Feedback
wMaxPacketSize 0x0004 1x 4 bytes
bInterval 4
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 3
bNumEndpoints 2
bInterfaceClass 1 Audio
bInterfaceSubClass 2 Streaming
bInterfaceProtocol 32
iInterface 4
AudioStreaming Interface Descriptor:
bLength 16
bDescriptorType 36
bDescriptorSubtype 1 (AS_GENERAL)
bTerminalLink 2
bmControls 0x00
bFormatType 1
bmFormats 0x80000000
bNrChannels 2
bmChannelConfig 0x00000000
iChannelNames 11
AudioStreaming Interface Descriptor:
bLength 6
bDescriptorType 36
bDescriptorSubtype 2 (FORMAT_TYPE)
bFormatType 1 (FORMAT_TYPE_I)
bSubslotSize 4
bBitResolution 32
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x01 EP 1 OUT
bmAttributes 5
Transfer Type Isochronous
Synch Type Asynchronous
Usage Type Data
wMaxPacketSize 0x0188 1x 392 bytes
bInterval 1
AudioStreaming Endpoint Descriptor:
bLength 8
bDescriptorType 37
bDescriptorSubtype 1 (EP_GENERAL)
bmAttributes 0x00
bmControls 0x00
bLockDelayUnits 2 Decoded PCM samples
wLockDelay 0x0008
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 17
Transfer Type Isochronous
Synch Type None
Usage Type Feedback
wMaxPacketSize 0x0004 1x 4 bytes
bInterval 4
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 2
bAlternateSetting 0
bNumEndpoints 0
bInterfaceClass 254 Application Specific Interface
bInterfaceSubClass 1 Device Firmware Update
bInterfaceProtocol 1
iInterface 10
Device Firmware Upgrade Interface Descriptor:
bLength 9
bDescriptorType 33
bmAttributes 7
Will Not Detach
Manifestation Tolerant
Upload Supported
Download Supported
wDetachTimeout 250 milliseconds
wTransferSize 64 bytes
bcdDFUVersion 1.10
Bus 001 Device 002: ID 2109:3431 VIA Labs, Inc. Hub
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.10
bDeviceClass 9 Hub
bDeviceSubClass 0
bDeviceProtocol 1 Single TT
bMaxPacketSize0 64
idVendor 0x2109 VIA Labs, Inc.
idProduct 0x3431 Hub
bcdDevice 4.21
iManufacturer 0
iProduct 1
iSerial 0
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType Couldn't open device, some information will be missing
2
wTotalLength 0x0019
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0xe0
Self Powered
Remote Wakeup
MaxPower 100mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 1
bInterfaceClass 9 Hub
bInterfaceSubClass 0
bInterfaceProtocol 0 Full speed (or root) hub
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0001 1x 1 bytes
bInterval 12
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.00
bDeviceClass 9 Hub
bDeviceSubClass 0
bDeviceProtocol 1 Single TT
bMaxPacketSize0 64
idVendor 0x1d6b Linux Foundation
idProduct 0x0002 2.0 root hub
bcdDevice 6.01
iManufacturer 3
iProduct 2
iSerial 1
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 0x0019
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0xe0
Self Powered
Remote Wakeup
MaxPower 0mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 1
bInterfaceClass 9 Hub
bInterfaceSubClass 0
bInterfaceProtocol 0 Full speed (or root) hub
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0004 1x 4 bytes
bInterval 12
# ps -ef ---------------
UID PID PPID C STIME TTY TIME CMD
root 1 0 1 18:26 ? 00:00:05 /sbin/init
root 2 0 0 18:26 ? 00:00:00 [kthreadd]
root 3 2 0 18:26 ? 00:00:00 [rcu_gp]
root 4 2 0 18:26 ? 00:00:00 [rcu_par_gp]
root 5 2 0 18:26 ? 00:00:00 [slub_flushwq]
root 6 2 0 18:26 ? 00:00:00 [netns]
root 7 2 0 18:26 ? 00:00:00 [kworker/0:0-events]
root 9 2 0 18:26 ? 00:00:01 [kworker/u8:0-events_unbound]
root 10 2 0 18:26 ? 00:00:00 [mm_percpu_wq]
root 11 2 0 18:26 ? 00:00:00 [rcu_tasks_rude_kthread]
root 12 2 0 18:26 ? 00:00:00 [rcu_tasks_trace_kthread]
root 13 2 0 18:26 ? 00:00:00 [ksoftirqd/0]
root 14 2 0 18:26 ? 00:00:00 [rcu_sched]
root 15 2 0 18:26 ? 00:00:00 [migration/0]
root 16 2 0 18:26 ? 00:00:00 [cpuhp/0]
root 17 2 0 18:26 ? 00:00:00 [cpuhp/1]
root 18 2 0 18:26 ? 00:00:00 [migration/1]
root 19 2 0 18:26 ? 00:00:00 [ksoftirqd/1]
root 20 2 0 18:26 ? 00:00:00 [kworker/1:0-events]
root 22 2 0 18:26 ? 00:00:00 [cpuhp/2]
root 23 2 0 18:26 ? 00:00:00 [migration/2]
root 24 2 0 18:26 ? 00:00:00 [ksoftirqd/2]
root 27 2 0 18:26 ? 00:00:00 [cpuhp/3]
root 28 2 0 18:26 ? 00:00:00 [migration/3]
root 29 2 0 18:26 ? 00:00:00 [ksoftirqd/3]
root 30 2 0 18:26 ? 00:00:00 [kworker/3:0-events]
root 32 2 0 18:26 ? 00:00:00 [kdevtmpfs]
root 33 2 0 18:26 ? 00:00:00 [inet_frag_wq]
root 34 2 0 18:26 ? 00:00:00 [kworker/0:1-events_freezable]
root 35 2 0 18:26 ? 00:00:00 [kauditd]
root 36 2 0 18:26 ? 00:00:00 [khungtaskd]
root 37 2 0 18:26 ? 00:00:01 [kworker/u8:1-loop0]
root 38 2 0 18:26 ? 00:00:00 [oom_reaper]
root 39 2 0 18:26 ? 00:00:00 [writeback]
root 40 2 0 18:26 ? 00:00:00 [kcompactd0]
root 41 2 0 18:26 ? 00:00:00 [kintegrityd]
root 42 2 0 18:26 ? 00:00:00 [kblockd]
root 43 2 0 18:26 ? 00:00:00 [blkcg_punt_bio]
root 44 2 0 18:26 ? 00:00:00 [watchdogd]
root 45 2 0 18:26 ? 00:00:00 [kworker/u8:2-events_unbound]
root 47 2 0 18:26 ? 00:00:00 [kworker/2:1-events]
root 48 2 0 18:26 ? 00:00:00 [kworker/1:1H-kblockd]
root 49 2 0 18:26 ? 00:00:00 [rpciod]
root 50 2 0 18:26 ? 00:00:00 [xprtiod]
root 51 2 0 18:26 ? 00:00:00 [kswapd0]
root 52 2 0 18:26 ? 00:00:00 [nfsiod]
root 53 2 0 18:26 ? 00:00:00 [kthrotld]
root 55 2 0 18:26 ? 00:00:00 [kworker/1:2-events_power_efficient]
root 59 2 0 18:26 ? 00:00:00 [kworker/3:1-events]
root 60 2 0 18:26 ? 00:00:00 [hwrng]
root 61 2 0 18:26 ? 00:00:00 [iscsi_conn_clea]
root 62 2 0 18:26 ? 00:00:00 [nvme-wq]
root 63 2 0 18:26 ? 00:00:00 [nvme-reset-wq]
root 64 2 0 18:26 ? 00:00:00 [nvme-delete-wq]
root 66 2 0 18:26 ? 00:00:00 [DWC Notificatio]
root 67 2 0 18:26 ? 00:00:00 [uas]
root 68 2 0 18:26 ? 00:00:00 [kworker/3:2-events]
root 69 2 0 18:26 ? 00:00:00 [vchiq-slot/0]
root 70 2 0 18:26 ? 00:00:00 [vchiq-recy/0]
root 71 2 0 18:26 ? 00:00:00 [vchiq-sync/0]
root 72 2 0 18:26 ? 00:00:00 [zswap-shrink]
root 73 2 0 18:26 ? 00:00:00 [kworker/u9:0-brcmf_wq/mmc1:0001:1]
root 95 2 0 18:26 ? 00:00:00 [sdhci]
root 96 2 0 18:26 ? 00:00:00 [irq/52-mmc0]
root 97 2 0 18:26 ? 00:00:00 [kworker/3:3-events]
root 98 2 0 18:26 ? 00:00:00 [kworker/3:4-mm_percpu_wq]
root 106 2 0 18:26 ? 00:00:00 [kworker/3:1H-kblockd]
root 107 2 0 18:26 ? 00:00:00 [mmc_complete]
root 108 2 0 18:26 ? 00:00:00 [kworker/0:1H-kblockd]
root 128 2 0 18:26 ? 00:00:00 [kworker/1:2H-kblockd]
root 132 2 0 18:26 ? 00:00:00 [kworker/0:2H-mmc_complete]
root 133 2 0 18:26 ? 00:00:00 [jbd2/mmcblk0p2-8]
root 134 2 0 18:26 ? 00:00:00 [ext4-rsv-conver]
root 136 2 0 18:26 ? 00:00:00 [kworker/2:1H-kblockd]
root 168 2 0 18:26 ? 00:00:00 [kworker/0:2-events_freezable]
root 169 2 0 18:26 ? 00:00:00 [jbd2/mmcblk0p3-8]
root 170 2 0 18:26 ? 00:00:00 [ext4-rsv-conver]
root 178 2 0 18:26 ? 00:00:00 [kworker/2:2H-kblockd]
root 179 2 0 18:26 ? 00:00:00 [mld]
root 180 2 0 18:26 ? 00:00:00 [ipv6_addrconf]
root 207 1 0 18:26 ? 00:00:00 /lib/systemd/systemd-journald
root 226 2 0 18:26 ? 00:00:00 [kworker/3:2H-kblockd]
root 231 1 0 18:26 ? 00:00:00 /lib/systemd/systemd-udevd
root 279 2 0 18:26 ? 00:00:00 [vchiq-keep/0]
root 282 2 0 18:26 ? 00:00:00 [SMIO]
root 314 2 0 18:26 ? 00:00:00 [mmal-vchiq]
root 319 2 0 18:26 ? 00:00:00 [mmal-vchiq]
root 322 2 0 18:26 ? 00:00:00 [irq/54-feb10000.codec]
root 324 2 0 18:26 ? 00:00:00 [mmal-vchiq]
root 328 2 0 18:26 ? 00:00:00 [mmal-vchiq]
root 330 2 0 18:26 ? 00:00:00 [mmal-vchiq]
root 334 2 0 18:26 ? 00:00:00 [mmal-vchiq]
root 338 2 0 18:26 ? 00:00:00 [mmal-vchiq]
root 347 2 0 18:26 ? 00:00:00 [cfg80211]
root 370 2 0 18:26 ? 00:00:00 [brcmf_wq/mmc1:0]
root 372 2 0 18:26 ? 00:00:00 [brcmf_wdog/mmc1:0001:1]
root 376 2 0 18:26 ? 00:00:00 [kworker/u9:2-hci0]
root 403 2 0 18:26 ? 00:00:00 [kworker/2:3-mm_percpu_wq]
root 443 1 0 18:26 ? 00:00:02 /usr/sbin/haveged --Foreground --verbose=1 -w 1024
root 458 2 0 18:26 ? 00:00:00 [kworker/3:5-events]
_rpc 462 1 0 18:26 ? 00:00:00 /sbin/rpcbind -f -w
message+ 483 1 0 18:26 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only
root 486 2 0 18:26 ? 00:00:00 [kworker/0:4-events_freezable]
root 507 1 0 18:26 ? 00:00:00 /lib/systemd/systemd-logind
nobody 513 1 0 18:26 ? 00:00:00 /usr/sbin/thd --triggers /etc/triggerhappy/triggers.d/ --socket /run/thd.socket --user nobody --deviceglob /dev/input/event*
root 523 1 0 18:26 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon
avahi 528 1 0 18:26 ? 00:00:00 avahi-daemon: running [sibermusic.local]
root 529 1 0 18:26 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant
volumio 530 1 0 18:26 ? 00:00:00 /usr/local/bin/volumio-remote-updater
avahi 578 528 0 18:26 ? 00:00:00 avahi-daemon: chroot helper
root 590 1 0 18:26 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap
shairpo+ 620 1 0 18:26 ? 00:00:00 /usr/bin/shairport-sync --configfile=/tmp/shairport-sync.conf
root 625 2 0 18:26 ? 00:00:00 [kworker/u8:4-loop0]
root 626 1 0 18:26 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group
root 649 1 0 18:26 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I
root 652 1 0 18:26 ? 00:00:00 /usr/sbin/sshd -D
ntp 654 1 0 18:26 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
root 678 1 0 18:26 tty1 00:00:00 /sbin/agetty -o -p -- \u --noclear tty1 linux
root 682 626 0 18:26 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group
root 767 1 0 18:27 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0
root 779 1 0 18:27 ? 00:00:00 /sbin/dhcpcd
root 845 1 0 18:27 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group
root 857 845 0 18:27 ? 00:00:00 winbindd: domain child [SIBERMUSIC]
volumio 859 1 7 18:27 ? 00:00:22 /usr/bin/node /volumio/index.js
root 861 1 0 18:27 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 878 861 0 18:27 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 879 861 0 18:27 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 880 845 0 18:27 ? 00:00:00 winbindd: idmap child
root 881 845 0 18:27 ? 00:00:00 winbindd: domain child [BUILTIN]
root 883 861 0 18:27 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 917 2 0 18:27 ? 00:00:00 [cifsiod]
root 918 2 0 18:27 ? 00:00:00 [smb3decryptd]
root 919 2 0 18:27 ? 00:00:00 [cifsfileinfoput]
root 920 2 0 18:27 ? 00:00:00 [cifsoplockd]
root 921 2 0 18:27 ? 00:00:00 [deferredclose]
root 923 2 0 18:27 ? 00:00:00 [cifsd]
volumio 938 859 0 18:27 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 947 938 0 18:27 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 948 938 0 18:27 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 954 938 0 18:27 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 1014 1 0 18:27 ? 00:00:00 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf
volumio 1127 1 0 18:27 ? 00:00:00 /bin/sh /bin/start-go-liberspot.sh
volumio 1129 1127 0 18:27 ? 00:00:00 /usr/bin/go-librespot -config_path /tmp/go-librespot-config.yml -credentials_path /data/configuration/music_service/spop/spotifycredentials.json
volumio 1138 1 0 18:27 ? 00:00:00 /bin/sh /usr/bin/startx /etc/X11/Xsession /opt/volumiokiosk.sh -- -nocursor
volumio 1165 1138 0 18:27 ? 00:00:00 xinit /etc/X11/Xsession /opt/volumiokiosk.sh -- /usr/bin/X :0 -nocursor -auth /tmp/serverauth.E2gqtoBe8X
root 1166 1165 0 18:27 tty2 00:00:00 /usr/lib/xorg/Xorg :0 -nocursor -auth /tmp/serverauth.E2gqtoBe8X
root 1209 2 0 18:27 ? 00:00:00 [rc0]
root 1341 1 0 18:27 ? 00:00:00 /usr/sbin/lircd --nodaemon
root 1344 1341 0 18:27 ? 00:00:00 [sh]
volumio 1346 1165 0 18:27 ? 00:00:00 /bin/bash /opt/volumiokiosk.sh
root 1382 1 0 18:27 ? 00:00:00 /usr/bin/irexec /etc/lirc/irexec.lircrc
volumio 1404 1346 0 18:27 ? 00:00:00 /usr/bin/ssh-agent /opt/volumiokiosk.sh
volumio 1413 1346 0 18:27 ? 00:00:00 /usr/bin/openbox --startup /usr/lib/arm-linux-gnueabihf/openbox-autostart OPENBOX
volumio 1414 1346 0 18:27 ? 00:00:02 /usr/lib/chromium-browser/chromium-browser-v7 --enable-pinch --simulate-outdated-no-au=Tue, 31 Dec 2099 23:59:59 GMT --force-device-scale-factor=0.9 --disable-pinch --kiosk --no-first-run --noerrdialogs --disable-3d-apis --disable-breakpad --disable-crash-reporter --disable-infobars --disable-session-crashed-bubble --disable-translate --user-data-dir=/data/volumiokiosk http://localhost:4004
volumio 1485 1 0 18:27 ? 00:00:00 /usr/lib/chromium-browser/crashpad_handler --monitor-self --monitor-self-annotation=ptype=crashpad-handler --database=/home/volumio/.config/chromium/Crash Reports --metrics-dir=/data/volumiokiosk --annotation=channel=Built on Raspbian , running on Raspbian 10 --annotation=lsb-release=Raspbian GNU/Linux 10 (buster) --annotation=plat=Linux --annotation=prod=Chrome_Linux --annotation=ver=92.0.4515.98 --initial-client-fd=7 --shared-client-connection
volumio 1487 1 0 18:27 ? 00:00:00 /usr/lib/chromium-browser/crashpad_handler --no-periodic-tasks --monitor-self-annotation=ptype=crashpad-handler --database=/home/volumio/.config/chromium/Crash Reports --annotation=channel=Built on Raspbian , running on Raspbian 10 --annotation=lsb-release=Raspbian GNU/Linux 10 (buster) --annotation=plat=Linux --annotation=prod=Chrome_Linux --annotation=ver=92.0.4515.98 --initial-client-fd=4 --shared-client-connection
volumio 1491 1414 0 18:27 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --no-zygote-sandbox --force-device-scale-factor=0.9 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad
volumio 1492 1414 0 18:27 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --force-device-scale-factor=0.9 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad
volumio 1494 1492 0 18:27 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --force-device-scale-factor=0.9 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad
volumio 1523 1414 0 18:27 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=utility --utility-sub-type=network.mojom.NetworkService --field-trial-handle=7505580978751396216,593127659249537140,131072 --lang=en-US --service-sandbox-type=none --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --shared-files=v8_context_snapshot_data:100 --enable-crashpad
volumio 1538 1491 0 18:27 ? 00:00:01 /usr/lib/chromium-browser/chromium-browser-v7 --type=gpu-process --field-trial-handle=7505580978751396216,593127659249537140,131072 --disable-breakpad --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --gpu-preferences=UAAAAAAAAAAgAAAQAAAAAAAAAAAAAAAAAABgAAAAAAAwAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAQAAANgAAAAAAAAA2AAAAAAAAABIAAAACAAAAEAAAAAAAAAASAAAAAAAAABQAAAAAAAAAFgAAAAAAAAAYAAAAAAAAABoAAAAAAAAAHAAAAAAAAAAeAAAAAAAAAAQAAAAAAAAAAAAAAAMAAAAEAAAAAAAAAAAAAAADQAAABAAAAAAAAAAAQAAAAwAAAAQAAAAAAAAAAEAAAANAAAAEAAAAAAAAAAEAAAADAAAABAAAAAAAAAABAAAAA0AAAAQAAAAAAAAAAcAAAAMAAAAEAAAAAAAAAAHAAAADQAAAAgAAAAAAAAACAAAAAAAAAA= --use-gl=swiftshader-webgl --shared-files
volumio 1541 1494 0 18:27 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=utility --utility-sub-type=storage.mojom.StorageService --field-trial-handle=7505580978751396216,593127659249537140,131072 --lang=en-US --service-sandbox-type=utility --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --shared-files=v8_context_snapshot_data:100
volumio 1546 1538 0 18:27 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=broker
volumio 1567 1494 0 18:27 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=renderer --disable-breakpad --force-device-scale-factor=0.9 --field-trial-handle=7505580978751396216,593127659249537140,131072 --disable-gpu-compositing --lang=en-US --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --disable-3d-apis --origin-trial-disabled-features=WebGPU --num-raster-threads=1 --renderer-client-id=7 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100
volumio 1568 1494 2 18:27 ? 00:00:08 /usr/lib/chromium-browser/chromium-browser-v7 --type=renderer --disable-breakpad --force-device-scale-factor=0.9 --field-trial-handle=7505580978751396216,593127659249537140,131072 --disable-gpu-compositing --lang=en-US --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --disable-3d-apis --origin-trial-disabled-features=WebGPU --num-raster-threads=1 --renderer-client-id=6 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100
volumio 1882 859 0 18:28 ? 00:00:00 /usr/bin/node /myvolumio/plugins/music_service/streaming_services/streamingProxy.js
root 2013 2 0 18:28 ? 00:00:00 [kworker/3:6]
mpd 2015 1 0 18:28 ? 00:00:00 /usr/bin/mpd --systemd
volumio 2051 1 0 18:28 ? 00:00:00 /bin/sh /bin/bt/btstart.sh start
volumio 2073 1 0 18:28 ? 00:00:00 /bin/sh /tmp/sshtunnel.sh
volumio 2075 1 0 18:28 ? 00:00:00 /usr/bin/pulseaudio --high-priority=true
volumio 2076 2073 0 18:28 ? 00:00:00 /usr/lib/autossh/autossh -M 0 -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R h0PZQsB39AURSlylidLe37OavVF3-88dd99399252828aa992fa9b2610eee3.eu2.myvolumio.org:8091:localhost:3000 eu2.myvolumio.org
rtkit 2079 1 0 18:28 ? 00:00:00 /usr/lib/rtkit/rtkit-daemon
volumio 2080 2076 0 18:28 ? 00:00:00 /usr/bin/ssh -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R h0PZQsB39AURSlylidLe37OavVF3-88dd99399252828aa992fa9b2610eee3.eu2.myvolumio.org:8091:localhost:3000 eu2.myvolumio.org
root 2083 1 0 18:28 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug
root 2105 2 0 18:28 ? 00:00:00 [krfcommd]
volumio 2109 2051 0 18:28 ? 00:00:00 /usr/bin/python /bin/bt/simple-agent -c NoInputNoOutput
volumio 2160 859 0 18:32 ? 00:00:00 /bin/sh -c /usr/bin/node /volumio/logsubmit.js 'NAS showing NaN MB after update to 3.601'
volumio 2161 2160 0 18:32 ? 00:00:00 /usr/bin/node /volumio/logsubmit.js NAS showing NaN MB after update to 3.601
volumio 2189 2161 0 18:32 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1
volumio 2190 2189 0 18:32 ? 00:00:00 ps -ef
# df -h ---------------
df: /mnt/NAS/sibernas: Resource temporarily unavailable
Filesystem Size Used Avail Use% Mounted on
/dev/mmcblk0p2 2.5G 1.1G 1.3G 47% /imgpart
/dev/loop0 489M 489M 0 100% /static
overlay 4.7G 2.7G 1.8G 60% /
devtmpfs 1.9G 0 1.9G 0% /dev
tmpfs 1.9G 19M 1.9G 1% /dev/shm
tmpfs 1.9G 5.3M 1.9G 1% /run
tmpfs 5.0M 4.0K 5.0M 1% /run/lock
tmpfs 1.9G 0 1.9G 0% /sys/fs/cgroup
tmpfs 1.9G 0 1.9G 0% /var/spool/cups
tmpfs 1.9G 448K 1.9G 1% /tmp
tmpfs 20M 44K 20M 1% /var/log
tmpfs 1.9G 0 1.9G 0% /var/spool/cups/tmp
/dev/mmcblk0p1 92M 66M 27M 72% /boot
# mount ---------------
/dev/mmcblk0p2 on /imgpart type ext4 (rw,relatime)
/dev/loop0 on /static type squashfs (ro,relatime,errors=continue)
overlay on / type overlay (rw,relatime,lowerdir=/mnt/static,upperdir=/mnt/ext/dyn,workdir=/mnt/ext/work)
sysfs on /sys type sysfs (rw,nosuid,nodev,noexec,relatime)
proc on /proc type proc (rw,relatime)
devtmpfs on /dev type devtmpfs (rw,nosuid,size=1925084k,nr_inodes=146414,mode=755)
securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime)
tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev,noexec)
devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000)
tmpfs on /run type tmpfs (rw,nosuid,nodev,mode=755)
tmpfs on /run/lock type tmpfs (rw,nosuid,nodev,noexec,relatime,size=5120k)
tmpfs on /sys/fs/cgroup type tmpfs (ro,nosuid,nodev,noexec,mode=755)
cgroup2 on /sys/fs/cgroup/unified type cgroup2 (rw,nosuid,nodev,noexec,relatime,nsdelegate)
cgroup on /sys/fs/cgroup/systemd type cgroup (rw,nosuid,nodev,noexec,relatime,xattr,name=systemd)
pstore on /sys/fs/pstore type pstore (rw,nosuid,nodev,noexec,relatime)
bpf on /sys/fs/bpf type bpf (rw,nosuid,nodev,noexec,relatime,mode=700)
cgroup on /sys/fs/cgroup/blkio type cgroup (rw,nosuid,nodev,noexec,relatime,blkio)
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/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpu,cpuacct)
cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer)
cgroup on /sys/fs/cgroup/pids type cgroup (rw,nosuid,nodev,noexec,relatime,pids)
cgroup on /sys/fs/cgroup/perf_event type cgroup (rw,nosuid,nodev,noexec,relatime,perf_event)
cgroup on /sys/fs/cgroup/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset)
cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices)
systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=45,pgrp=1,timeout=0,minproto=5,maxproto=5,direct)
debugfs on /sys/kernel/debug type debugfs (rw,relatime)
sunrpc on /run/rpc_pipefs type rpc_pipefs (rw,relatime)
mqueue on /dev/mqueue type mqueue (rw,relatime)
configfs on /sys/kernel/config type configfs (rw,relatime)
tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755)
tmpfs on /tmp type tmpfs (rw,noatime,mode=755)
tmpfs on /var/log type tmpfs (rw,nodev,relatime,size=20480k,mode=777,uid=1000,gid=4)
tmpfs on /var/spool/cups/tmp type tmpfs (rw,noatime,mode=755)
/dev/mmcblk0p1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=ascii,shortname=mixed,utf8,errors=remount-ro,user)
none on /cpusets type cgroup (rw,relatime,cpuset)
//192.168.178.10/sibernas on /mnt/NAS/sibernas type cifs (ro,relatime,vers=3.1.1,cache=strict,username=pi,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.178.10,file_mode=0666,dir_mode=0777,iocharset=utf8,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=1048576,echo_interval=60,actimeo=1,closetimeo=1)
# netstat -natp ---------------
(Not all processes could be identified, non-owned process info
will not be shown, you would have to be root to see it all.)
Active Internet connections (servers and established)
Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name
tcp 0 0 0.0.0.0:139 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:4713 0.0.0.0:* LISTEN 2075/pulseaudio
tcp 0 0 0.0.0.0:111 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:22 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:49152 0.0.0.0:* LISTEN 1014/upmpdcli
tcp 0 0 0.0.0.0:49149 0.0.0.0:* LISTEN 1014/upmpdcli
tcp 0 0 0.0.0.0:5000 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:445 0.0.0.0:* LISTEN -
tcp 0 0 192.168.178.227:47634 84.247.14.230:80 ESTABLISHED 859/node
tcp 0 0 192.168.178.227:56904 185.14.187.123:2222 ESTABLISHED 2080/ssh
tcp 0 0 192.168.178.227:45342 192.168.178.73:3000 ESTABLISHED 859/node
tcp 0 0 127.0.0.1:60994 127.0.0.1:3000 TIME_WAIT -
tcp 0 0 127.0.0.1:35844 127.0.0.1:6599 ESTABLISHED 1014/upmpdcli
tcp 0 0 192.168.178.227:58166 142.251.36.3:443 ESTABLISHED 1523/volumiokiosk -
tcp 0 0 192.168.178.227:45078 34.158.0.131:4070 ESTABLISHED 1129/go-librespot
tcp 0 0 127.0.0.1:35852 127.0.0.1:6599 ESTABLISHED 1014/upmpdcli
tcp 0 0 127.0.0.1:36200 127.0.0.1:9879 ESTABLISHED 859/node
tcp 0 0 192.168.178.227:56734 172.217.168.202:443 ESTABLISHED 1523/volumiokiosk -
tcp 0 0 192.168.178.227:33748 35.190.39.113:443 ESTABLISHED 859/node
tcp 0 0 127.0.0.1:46012 127.0.0.1:3000 ESTABLISHED 859/node
tcp 0 0 127.0.0.1:50238 127.0.0.1:3000 ESTABLISHED 1523/volumiokiosk -
tcp 0 0 192.168.178.227:38280 35.186.224.34:443 ESTABLISHED 1129/go-librespot
tcp 0 0 127.0.0.1:45984 127.0.0.1:3000 ESTABLISHED 530/volumio-remote-
tcp 0 0 127.0.0.1:39682 127.0.0.1:3000 ESTABLISHED 859/node
tcp 0 0 127.0.0.1:39726 127.0.0.1:3000 ESTABLISHED 859/node
tcp 0 0 192.168.178.227:40494 142.250.27.84:443 TIME_WAIT -
tcp 0 0 127.0.0.1:59398 127.0.0.1:3000 ESTABLISHED 859/node
tcp 0 0 127.0.0.1:59426 127.0.0.1:3000 ESTABLISHED 859/node
tcp 0 0 192.168.178.227:44138 192.168.178.10:445 ESTABLISHED -
tcp6 0 0 :::9879 :::* LISTEN 1129/go-librespot
tcp6 0 0 :::139 :::* LISTEN -
tcp6 0 0 :::3245 :::* LISTEN 1882/node
tcp6 0 0 :::4713 :::* LISTEN 2075/pulseaudio
tcp6 0 0 :::111 :::* LISTEN -
tcp6 0 0 :::22 :::* LISTEN -
tcp6 0 0 :::6599 :::* LISTEN 859/node
tcp6 0 0 :::6600 :::* LISTEN -
tcp6 0 0 :::5000 :::* LISTEN -
tcp6 0 0 :::3000 :::* LISTEN 859/node
tcp6 0 0 :::3001 :::* LISTEN 938/node
tcp6 0 0 :::3005 :::* LISTEN 859/node
tcp6 0 0 :::445 :::* LISTEN -
tcp6 0 0 :::4004 :::* LISTEN 859/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:50238 ESTABLISHED 859/node
tcp6 0 0 127.0.0.1:6599 127.0.0.1:35844 ESTABLISHED 859/node
tcp6 0 0 192.168.178.227:3000 192.168.178.123:61479 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:39682 ESTABLISHED 859/node
tcp6 0 0 192.168.178.227:3000 192.168.178.73:60498 ESTABLISHED 859/node
tcp6 0 0 192.168.178.227:3000 192.168.178.123:61476 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:46012 ESTABLISHED 859/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:59398 ESTABLISHED 859/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:39726 ESTABLISHED 859/node
tcp6 0 0 192.168.178.227:3000 192.168.178.123:61488 ESTABLISHED 859/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:59426 ESTABLISHED 859/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:45984 ESTABLISHED 859/node
tcp6 0 0 127.0.0.1:6599 127.0.0.1:35852 ESTABLISHED 859/node
tcp6 0 0 192.168.178.227:3000 192.168.178.123:61477 TIME_WAIT -
tcp6 0 0 192.168.178.227:3000 192.168.178.66:57940 ESTABLISHED 859/node
tcp6 0 0 127.0.0.1:9879 127.0.0.1:36200 ESTABLISHED 1129/go-librespot
# cat /etc/asound.conf ---------------
pcm.!default {
type empty
slave.pcm "volumio"
}
pcm.volumio {
type empty
slave.pcm "volumioMultiRoomServer"
}
# This PCM switches output to the ALSA target named by the file /tmp/multiroom/server/switch.target
pcm.volumioMultiRoomServer {
type volumioswitch
target_file "/tmp/multiroom/server/switch.target"
control_fifo "/tmp/multiroom/server/switch.fifo"
format_append "true"
format_1 "DSD_U32_BE"
rate_min 44100
rate_max 384000
}
# This PCM switches output to the ALSA target named by the file /tmp/multiroom/client/switch.target
pcm.volumioMultiRoomClient {
type volumioswitch
target_file "/tmp/multiroom/client/switch.target"
control_fifo "/tmp/multiroom/client/switch.fifo"
}
# This PCM performs any necessary rate/format/channel conversion before sending on to the Server FIFO
pcm.volumioMultiRoom {
type plug
slave {
pcm "volumioMultiRoomFIFO"
rate 48000
format "S16_LE"
channels 2
}
rate_converter "speexrate_medium"
}
# Write to the FIFO watched by the Server
pcm.volumioMultiRoomFIFO {
type volumiofifo
fifo "/tmp/multiroom/server/fifo"
clear_on_drop false
lead_in_frames 16384
}
# This pcm is used by pcm.volumioMultiRoomServer and pcm.volumioMultiRoomClient to play audio on the local output
pcm.volumioLocalPlayback {
type empty
slave.pcm "postMultiRoom"
}
# This pcm is used by pcm.volumioMultiRoomClient to discard audio and allow for faster switching
pcm.volumioDiscard {
type null
}
pcm.postMultiRoom {
type empty
slave.pcm "volumioOutput"
}
# There is always a plug before the hardware to be safe
pcm.volumioOutput {
type plug
slave.pcm "volumioHw"
}
pcm.volumioHw {
type hw
card "D10s"
}
# cat /var/log/mpd.log ---------------
Jan 28 22:56 : zeroconf: No global port, disabling zeroconf
Jan 28 22:56 : exception: No such directory
Jan 30 18:28 : zeroconf: No global port, disabling zeroconf
# cat /tmp/camilladsp.log ---------------
cat: /tmp/camilladsp.log: No such file or directory
# cat /tmp/cec-client.log ---------------
cat: /tmp/cec-client.log: No such file or directory
# volumio plugin list ---------------
This command will list installed plugins on your device
----------------------- Installed Plugins:
[
{
prettyName: 'Bandcamp Discover',
name: 'bandcamp',
category: 'music_service',
version: '1.1.0',
icon: 'fa-bandcamp',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'Spotify',
name: 'spop',
category: 'music_service',
version: '4.0.4',
icon: 'fa-spotify',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'YouTube Music',
name: 'ytmusic',
category: 'music_service',
version: '1.0.0',
icon: 'fa-youtube-play',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'IR Remote Controller',
name: 'ir_controller',
category: 'system_hardware',
version: '3.4.11',
icon: 'fa-magic',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'Music Services Shield',
name: 'music_services_shield',
category: 'system_hardware',
version: '1.3.1',
icon: 'fa-shield',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'Now Playing',
name: 'now_playing',
category: 'user_interface',
version: '0.5.4',
icon: 'fa-play-circle',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'Touch Display',
name: 'touch_display',
category: 'user_interface',
version: '3.3.7',
icon: 'fa-hand-pointer-o',
isManuallyInstalled: false,
enabled: true,
active: true
}
]
------------------------------------------
# cat /data/configuration/plugins.json ---------------
{
"music_service": {
"airplay_emulation": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STOPPED"
}
},
"inputs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"mpd": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"webradio": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"example_plugin": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STOPPED"
}
},
"last_100": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"upnp_browser": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"streaming_services": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"cd_controller": {
"status": {
"type": "string",
"value": "STOPPED"
},
"enabled": {
"type": "boolean",
"value": false
}
},
"smart_inputs": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"hi_res_audio": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"tidal": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"qobuz": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"tidalconnect": {
"status": {
"type": "string",
"value": "STOPPED"
},
"enabled": {
"type": "boolean",
"value": false
}
},
"bandcamp": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"spop": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"ytmusic": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"audio_interface": {
"outputs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"upnp": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"alsa_controller": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"bluetooth": {
"status": {
"type": "string",
"value": "STARTED"
},
"enabled": {
"type": "boolean",
"value": true
}
},
"multiroom": {
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"miscellanea": {
"alarm-clock": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"albumart": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"appearance": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"wizard": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"my_music": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"metavolumio": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"manifestui": {
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"user_interface": {
"websocket": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"mpdemulation": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"rest_api": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"touch_display": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"now_playing": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"system_controller": {
"updater_comm": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"network": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"networkfs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"services": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"system": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"i2s_dacs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volumiodiscovery": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volumio_command_line_client": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"my_volumio": {
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"system_hardware": {
"ir_controller": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"music_services_shield": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
}
}
}
# cat /etc/mpd.conf ---------------
# Volumio MPD Configuration File
# Files and directories #######################################################
music_directory "/var/lib/mpd/music"
playlist_directory "/var/lib/mpd/playlists"
db_file "/var/lib/mpd/tag_cache"
log_file "/var/log/mpd.log"
#pid_file "/var/run/mpd/pid"
#state_file "/var/lib/mpd/state"
#sticker_file "/var/lib/mpd/sticker.sql"
###############################################################################
# General music daemon options ################################################
user "mpd"
group "audio"
bind_to_address "any"
#port "6600"
log_level "default"
#save_absolute_paths_in_playlists "no"
#metadata_to_use "artist,album,title,track,name,genre,date,composer,performer,disc"
auto_update "no"
#auto_update_depth "3"
###############################################################################
# Symbolic link behavior ######################################################
follow_outside_symlinks "yes"
follow_inside_symlinks "yes"
###############################################################################
# Input #######################################################################
#
input {
plugin "curl"
# proxy "proxy.isp.com:8080"
# proxy_user "user"
# proxy_password "password"
}
###############################################################################
# Decoder ################################################################
decoder {
plugin "faad"
enabled "no"
}
###############################################################################
# Audio Output ################################################################
resampler {
plugin "soxr"
quality "high"
threads "1"
}
audio_output {
type "alsa"
name "alsa"
device "volumio"
dop "no"
}
audio_output {
type "fifo"
enabled "no"
name "multiroom"
path "/tmp/snapfifo"
format "44100:16:2"
}
#replaygain "album"
#replaygain_preamp "0"
volume_normalization "no"
###############################################################################
# MPD Internal Buffering ######################################################
audio_buffer_size "2048"
###############################################################################
# Resource Limitations ########################################################
#connection_timeout "60"
max_connections "20"
max_playlist_length "81920"
max_command_list_size "81920"
max_output_buffer_size "81920"
###############################################################################
# Character Encoding ##########################################################
filesystem_charset "UTF-8"
###############################################################################
# volumio endpointstest ---------------
TESTING REMOTE ENDPOINTS
https://google.com, 382 ms: OK
https://www.googleapis.com, 257 ms: OK
https://securetoken.googleapis.com, 299 ms: OK
https://myvolumio.firebaseio.com, 412 ms: OK
https://functions.volumio.cloud, 362 ms: OK
https://oauth-performer.dfs.volumio.org, 235 ms: OK
https://browsing-performer.dfs.volumio.org, 340 ms: OK
http://cddb.volumio.org, 521 ms: OK
https://functions.volumio.cloud, 446 ms: OK
http://pushupdates.volumio.org, 320 ms: OK
http://plugins.volumio.org, 669 ms: OK
https://database.volumio.cloud, 470 ms: OK
https://radio-directory.firebaseapp.com, 1801 ms: OK
----------
REMOTE ENDPOINTS TEST OK, all Endpoints are reachable
----------
# cat /data/updatesHistoryFile ---------------
---
Fri Oct 20 2023 13:46:04 GMT+0000 (Coordinated Universal Time)
{"systemversion":"3.569","builddate":"Fri 20 Oct 2023 03:38:28 PM CEST","variant":"volumio","hardware":"pi"}
------
Sun Jan 28 2024 22:52:35 GMT+0100 (Central European Standard Time)
{"systemversion":"3.601","builddate":"Fri 19 Jan 2024 06:17:59 PM CET","variant":"volumio","hardware":"pi"}
---
# sudo journalctl -p 7 ---------------
-- Logs begin at Sun 2024-01-28 22:55:54 CET, end at Tue 2024-01-30 18:32:33 CET. --
Jan 28 22:55:54 sibermusic kernel: Booting Linux on physical CPU 0x0
Jan 28 22:55:54 sibermusic kernel: Linux version 6.1.70-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1712 SMP Tue Jan 2 18:29:06 GMT 2024
Jan 28 22:55:54 sibermusic kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
Jan 28 22:55:54 sibermusic kernel: CPU: div instructions available: patching division code
Jan 28 22:55:54 sibermusic kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
Jan 28 22:55:54 sibermusic kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.2
Jan 28 22:55:54 sibermusic kernel: random: crng init done
Jan 28 22:55:54 sibermusic kernel: Memory policy: Data cache writealloc
Jan 28 22:55:54 sibermusic kernel: Reserved memory: created CMA memory pool at 0x000000002a000000, size 64 MiB
Jan 28 22:55:54 sibermusic kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Jan 28 22:55:54 sibermusic kernel: Zone ranges:
Jan 28 22:55:54 sibermusic kernel: DMA [mem 0x0000000000000000-0x000000002fffffff]
Jan 28 22:55:54 sibermusic kernel: Normal empty
Jan 28 22:55:54 sibermusic kernel: HighMem [mem 0x0000000030000000-0x00000000fbffffff]
Jan 28 22:55:54 sibermusic kernel: Movable zone start for each node
Jan 28 22:55:54 sibermusic kernel: Early memory node ranges
Jan 28 22:55:54 sibermusic kernel: node 0: [mem 0x0000000000000000-0x000000003b3fffff]
Jan 28 22:55:54 sibermusic kernel: node 0: [mem 0x0000000040000000-0x00000000fbffffff]
Jan 28 22:55:54 sibermusic kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff]
Jan 28 22:55:54 sibermusic kernel: percpu: Embedded 17 pages/cpu s37012 r8192 d24428 u69632
Jan 28 22:55:54 sibermusic kernel: pcpu-alloc: s37012 r8192 d24428 u69632 alloc=17*4096
Jan 28 22:55:54 sibermusic kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
Jan 28 22:55:54 sibermusic kernel: Built 1 zonelists, mobility grouping on. Total pages: 1011008
Jan 28 22:55:54 sibermusic kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:6C:7A:FC vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0
Jan 28 22:55:54 sibermusic kernel: Kernel parameter elevator= does not have any effect anymore.
Please use sysfs to set IO scheduler for individual devices.
Jan 28 22:55:54 sibermusic kernel: Unknown kernel command line parameters "splash imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh bootdelay=5", will be passed to user space.
Jan 28 22:55:54 sibermusic kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Jan 28 22:55:54 sibermusic kernel: software IO TLB: area num 4.
Jan 28 22:55:54 sibermusic kernel: software IO TLB: mapped [mem 0x0000000023c90000-0x0000000027c90000] (64MB)
Jan 28 22:55:54 sibermusic kernel: Memory: 3850168K/4050944K available (10240K kernel code, 1504K rwdata, 3384K rodata, 2048K init, 638K bss, 135240K reserved, 65536K cma-reserved, 3264512K highmem)
Jan 28 22:55:54 sibermusic kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Jan 28 22:55:54 sibermusic kernel: ftrace: allocating 37228 entries in 110 pages
Jan 28 22:55:54 sibermusic kernel: ftrace: allocated 110 pages with 5 groups
Jan 28 22:55:54 sibermusic kernel: trace event string verifier disabled
Jan 28 22:55:54 sibermusic kernel: rcu: Hierarchical RCU implementation.
Jan 28 22:55:54 sibermusic kernel: Rude variant of Tasks RCU enabled.
Jan 28 22:55:54 sibermusic kernel: Tracing variant of Tasks RCU enabled.
Jan 28 22:55:54 sibermusic kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
Jan 28 22:55:54 sibermusic kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Jan 28 22:55:54 sibermusic kernel: GIC: Using split EOI/Deactivate mode
Jan 28 22:55:54 sibermusic kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
Jan 28 22:55:54 sibermusic kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys).
Jan 28 22:55:54 sibermusic kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
Jan 28 22:55:54 sibermusic kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
Jan 28 22:55:54 sibermusic kernel: Switching to timer-based delay loop, resolution 18ns
Jan 28 22:55:54 sibermusic kernel: Console: colour dummy device 80x30
Jan 28 22:55:54 sibermusic kernel: printk: console [tty1] enabled
Jan 28 22:55:54 sibermusic kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
Jan 28 22:55:54 sibermusic kernel: CPU: Testing write buffer coherency: ok
Jan 28 22:55:54 sibermusic kernel: CPU0: Spectre BHB: enabling loop workaround for all CPUs
Jan 28 22:55:54 sibermusic kernel: pid_max: default: 32768 minimum: 301
Jan 28 22:55:54 sibermusic kernel: LSM: Security Framework initializing
Jan 28 22:55:54 sibermusic kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: cgroup: Disabling memory control group subsystem
Jan 28 22:55:54 sibermusic kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Jan 28 22:55:54 sibermusic kernel: cblist_init_generic: Setting adjustable number of callback queues.
Jan 28 22:55:54 sibermusic kernel: cblist_init_generic: Setting shift to 2 and lim to 1.
Jan 28 22:55:54 sibermusic kernel: cblist_init_generic: Setting adjustable number of callback queues.
Jan 28 22:55:54 sibermusic kernel: cblist_init_generic: Setting shift to 2 and lim to 1.
Jan 28 22:55:54 sibermusic kernel: Setting up static identity map for 0x200000 - 0x20003c
Jan 28 22:55:54 sibermusic kernel: rcu: Hierarchical SRCU implementation.
Jan 28 22:55:54 sibermusic kernel: rcu: Max phase no-delay instances is 1000.
Jan 28 22:55:54 sibermusic kernel: smp: Bringing up secondary CPUs ...
Jan 28 22:55:54 sibermusic kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Jan 28 22:55:54 sibermusic kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Jan 28 22:55:54 sibermusic kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Jan 28 22:55:54 sibermusic kernel: smp: Brought up 1 node, 4 CPUs
Jan 28 22:55:54 sibermusic kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS).
Jan 28 22:55:54 sibermusic kernel: CPU: All CPU(s) started in HYP mode.
Jan 28 22:55:54 sibermusic kernel: CPU: Virtualization extensions available.
Jan 28 22:55:54 sibermusic kernel: devtmpfs: initialized
Jan 28 22:55:54 sibermusic kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
Jan 28 22:55:54 sibermusic kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Jan 28 22:55:54 sibermusic kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: pinctrl core: initialized pinctrl subsystem
Jan 28 22:55:54 sibermusic kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Jan 28 22:55:54 sibermusic kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations
Jan 28 22:55:54 sibermusic kernel: audit: initializing netlink subsys (disabled)
Jan 28 22:55:54 sibermusic kernel: audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1
Jan 28 22:55:54 sibermusic kernel: thermal_sys: Registered thermal governor 'step_wise'
Jan 28 22:55:54 sibermusic kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Jan 28 22:55:54 sibermusic kernel: hw-breakpoint: maximum watchpoint size is 8 bytes.
Jan 28 22:55:54 sibermusic kernel: Serial: AMBA PL011 UART driver
Jan 28 22:55:54 sibermusic kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled
Jan 28 22:55:54 sibermusic kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2023-10-17T15:39:16, variant start
Jan 28 22:55:54 sibermusic kernel: raspberrypi-firmware soc:firmware: Firmware hash is 30f0c5e4d076da3ab4f341d88e7d505760b93ad7
Jan 28 22:55:54 sibermusic kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
Jan 28 22:55:54 sibermusic kernel: bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
Jan 28 22:55:54 sibermusic kernel: SCSI subsystem initialized
Jan 28 22:55:54 sibermusic kernel: usbcore: registered new interface driver usbfs
Jan 28 22:55:54 sibermusic kernel: usbcore: registered new interface driver hub
Jan 28 22:55:54 sibermusic kernel: usbcore: registered new device driver usb
Jan 28 22:55:54 sibermusic kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator
Jan 28 22:55:54 sibermusic kernel: pps_core: LinuxPPS API ver. 1 registered
Jan 28 22:55:54 sibermusic kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti
Jan 28 22:55:54 sibermusic kernel: PTP clock support registered
Jan 28 22:55:54 sibermusic kernel: vgaarb: loaded
Jan 28 22:55:54 sibermusic kernel: clocksource: Switched to clocksource arch_sys_counter
Jan 28 22:55:54 sibermusic kernel: VFS: Disk quotas dquot_6.6.0
Jan 28 22:55:54 sibermusic kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Jan 28 22:55:54 sibermusic kernel: FS-Cache: Loaded
Jan 28 22:55:54 sibermusic kernel: CacheFiles: Loaded
Jan 28 22:55:54 sibermusic kernel: NET: Registered PF_INET protocol family
Jan 28 22:55:54 sibermusic kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: TCP: Hash tables configured (established 8192 bind 8192)
Jan 28 22:55:54 sibermusic kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
Jan 28 22:55:54 sibermusic kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Jan 28 22:55:54 sibermusic kernel: RPC: Registered named UNIX socket transport module.
Jan 28 22:55:54 sibermusic kernel: RPC: Registered udp transport module.
Jan 28 22:55:54 sibermusic kernel: RPC: Registered tcp transport module.
Jan 28 22:55:54 sibermusic kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Jan 28 22:55:54 sibermusic kernel: PCI: CLS 0 bytes, default 64
Jan 28 22:55:54 sibermusic kernel: Trying to unpack rootfs image as initramfs...
Jan 28 22:55:54 sibermusic kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
Jan 28 22:55:54 sibermusic kernel: Initialise system trusted keyrings
Jan 28 22:55:54 sibermusic kernel: workingset: timestamp_bits=14 max_order=20 bucket_order=6
Jan 28 22:55:54 sibermusic kernel: zbud: loaded
Jan 28 22:55:54 sibermusic kernel: NFS: Registering the id_resolver key type
Jan 28 22:55:54 sibermusic kernel: Key type id_resolver registered
Jan 28 22:55:54 sibermusic kernel: Key type id_legacy registered
Jan 28 22:55:54 sibermusic kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Jan 28 22:55:54 sibermusic kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
Jan 28 22:55:54 sibermusic kernel: Key type asymmetric registered
Jan 28 22:55:54 sibermusic kernel: Asymmetric key parser 'x509' registered
Jan 28 22:55:54 sibermusic kernel: bounce: pool size: 64 pages
Jan 28 22:55:54 sibermusic kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
Jan 28 22:55:54 sibermusic kernel: io scheduler mq-deadline registered
Jan 28 22:55:54 sibermusic kernel: io scheduler kyber registered
Jan 28 22:55:54 sibermusic kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
Jan 28 22:55:54 sibermusic kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
Jan 28 22:55:54 sibermusic kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000
Jan 28 22:55:54 sibermusic kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000
Jan 28 22:55:54 sibermusic kernel: brcm-pcie fd500000.pcie: setting SCB_ACCESS_EN, READ_UR_MODE, MAX_BURST_SIZE
Jan 28 22:55:54 sibermusic kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
Jan 28 22:55:54 sibermusic kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
Jan 28 22:55:54 sibermusic kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
Jan 28 22:55:54 sibermusic kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
Jan 28 22:55:54 sibermusic kernel: pci 0000:00:00.0: PME# supported from D0 D3hot
Jan 28 22:55:54 sibermusic kernel: PCI: bus0: Fast back to back transfers disabled
Jan 28 22:55:54 sibermusic kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring
Jan 28 22:55:54 sibermusic kernel: pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator
Jan 28 22:55:54 sibermusic kernel: pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator
Jan 28 22:55:54 sibermusic kernel: pci_bus 0000:01: supply vpcie12v not found, using dummy regulator
Jan 28 22:55:54 sibermusic kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
Jan 28 22:55:54 sibermusic kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
Jan 28 22:55:54 sibermusic kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
Jan 28 22:55:54 sibermusic kernel: pci 0000:01:00.0: PME# supported from D0 D3cold
Jan 28 22:55:54 sibermusic kernel: PCI: bus1: Fast back to back transfers disabled
Jan 28 22:55:54 sibermusic kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
Jan 28 22:55:54 sibermusic kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
Jan 28 22:55:54 sibermusic kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
Jan 28 22:55:54 sibermusic kernel: pci 0000:00:00.0: PCI bridge to [bus 01]
Jan 28 22:55:54 sibermusic kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff]
Jan 28 22:55:54 sibermusic kernel: pcieport 0000:00:00.0: enabling device (0000 -> 0002)
Jan 28 22:55:54 sibermusic kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 45
Jan 28 22:55:54 sibermusic kernel: bcm2708_fb soc:fb: FB found 1 display(s)
Jan 28 22:55:54 sibermusic kernel: Console: switching to colour frame buffer device 100x30
Jan 28 22:55:54 sibermusic kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 800x480
Jan 28 22:55:54 sibermusic kernel: iproc-rng200 fe104000.rng: hwrng registered
Jan 28 22:55:54 sibermusic kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Jan 28 22:55:54 sibermusic kernel: brd: module loaded
Jan 28 22:55:54 sibermusic kernel: loop: module loaded
Jan 28 22:55:54 sibermusic kernel: Loading iSCSI transport class v2.0-870.
Jan 28 22:55:54 sibermusic kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
Jan 28 22:55:54 sibermusic kernel: Freeing initrd memory: 13624K
Jan 28 22:55:54 sibermusic kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
Jan 28 22:55:54 sibermusic kernel: usbcore: registered new device driver r8152-cfgselector
Jan 28 22:55:54 sibermusic kernel: usbcore: registered new interface driver r8152
Jan 28 22:55:54 sibermusic kernel: usbcore: registered new interface driver lan78xx
Jan 28 22:55:54 sibermusic kernel: usbcore: registered new interface driver smsc95xx
Jan 28 22:55:54 sibermusic kernel: xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142)
Jan 28 22:55:54 sibermusic kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller
Jan 28 22:55:54 sibermusic kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
Jan 28 22:55:54 sibermusic kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0b00040000000890
Jan 28 22:55:54 sibermusic kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller
Jan 28 22:55:54 sibermusic kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
Jan 28 22:55:54 sibermusic kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
Jan 28 22:55:54 sibermusic kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01
Jan 28 22:55:54 sibermusic kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan 28 22:55:54 sibermusic kernel: usb usb1: Product: xHCI Host Controller
Jan 28 22:55:54 sibermusic kernel: usb usb1: Manufacturer: Linux 6.1.70-v7l+ xhci-hcd
Jan 28 22:55:54 sibermusic kernel: usb usb1: SerialNumber: 0000:01:00.0
Jan 28 22:55:54 sibermusic kernel: hub 1-0:1.0: USB hub found
Jan 28 22:55:54 sibermusic kernel: hub 1-0:1.0: 1 port detected
Jan 28 22:55:54 sibermusic kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01
Jan 28 22:55:54 sibermusic kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan 28 22:55:54 sibermusic kernel: usb usb2: Product: xHCI Host Controller
Jan 28 22:55:54 sibermusic kernel: usb usb2: Manufacturer: Linux 6.1.70-v7l+ xhci-hcd
Jan 28 22:55:54 sibermusic kernel: usb usb2: SerialNumber: 0000:01:00.0
Jan 28 22:55:54 sibermusic kernel: hub 2-0:1.0: USB hub found
Jan 28 22:55:54 sibermusic kernel: hub 2-0:1.0: 4 ports detected
Jan 28 22:55:54 sibermusic kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Jan 28 22:55:54 sibermusic kernel: dwc_otg: FIQ enabled
Jan 28 22:55:54 sibermusic kernel: dwc_otg: NAK holdoff enabled
Jan 28 22:55:54 sibermusic kernel: dwc_otg: FIQ split-transaction FSM enabled
Jan 28 22:55:54 sibermusic kernel: Module dwc_common_port init
Jan 28 22:55:54 sibermusic kernel: usbcore: registered new interface driver uas
Jan 28 22:55:54 sibermusic kernel: usbcore: registered new interface driver usb-storage
Jan 28 22:55:54 sibermusic kernel: mousedev: PS/2 mouse device common for all mice
Jan 28 22:55:54 sibermusic kernel: sdhci: Secure Digital Host Controller Interface driver
Jan 28 22:55:54 sibermusic kernel: sdhci: Copyright(c) Pierre Ossman
Jan 28 22:55:54 sibermusic kernel: sdhci-pltfm: SDHCI platform and OF driver helper
Jan 28 22:55:54 sibermusic kernel: ledtrig-cpu: registered to indicate activity on CPUs
Jan 28 22:55:54 sibermusic kernel: hid: raw HID events driver (C) Jiri Kosina
Jan 28 22:55:54 sibermusic kernel: usbcore: registered new interface driver usbhid
Jan 28 22:55:54 sibermusic kernel: usbhid: USB HID core driver
Jan 28 22:55:54 sibermusic kernel: Initializing XFRM netlink socket
Jan 28 22:55:54 sibermusic kernel: NET: Registered PF_PACKET protocol family
Jan 28 22:55:54 sibermusic kernel: Key type dns_resolver registered
Jan 28 22:55:54 sibermusic kernel: Registering SWP/SWPB emulation handler
Jan 28 22:55:54 sibermusic kernel: registered taskstats version 1
Jan 28 22:55:54 sibermusic kernel: Loading compiled-in X.509 certificates
Jan 28 22:55:54 sibermusic kernel: Key type .fscrypt registered
Jan 28 22:55:54 sibermusic kernel: Key type fscrypt-provisioning registered
Jan 28 22:55:54 sibermusic kernel: uart-pl011 fe201000.serial: there is not valid maps for state default
Jan 28 22:55:54 sibermusic kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled
Jan 28 22:55:54 sibermusic kernel: fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 51, base_baud = 0) is a PL011 rev2
Jan 28 22:55:54 sibermusic kernel: serial serial0: tty port ttyAMA1 registered
Jan 28 22:55:54 sibermusic kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Jan 28 22:55:54 sibermusic kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Jan 28 22:55:54 sibermusic kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
Jan 28 22:55:54 sibermusic kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
Jan 28 22:55:54 sibermusic kernel: of_cfs_init
Jan 28 22:55:54 sibermusic kernel: of_cfs_init: OK
Jan 28 22:55:54 sibermusic kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
Jan 28 22:55:54 sibermusic kernel: Freeing unused kernel image (initmem) memory: 2048K
Jan 28 22:55:54 sibermusic kernel: Run /init as init process
Jan 28 22:55:54 sibermusic kernel: with arguments:
Jan 28 22:55:54 sibermusic kernel: /init
Jan 28 22:55:54 sibermusic kernel: splash
Jan 28 22:55:54 sibermusic kernel: with environment:
Jan 28 22:55:54 sibermusic kernel: HOME=/
Jan 28 22:55:54 sibermusic kernel: TERM=linux
Jan 28 22:55:54 sibermusic kernel: imgpart=/dev/mmcblk0p2
Jan 28 22:55:54 sibermusic kernel: imgfile=/volumio_current.sqsh
Jan 28 22:55:54 sibermusic kernel: bootdelay=5
Jan 28 22:55:54 sibermusic kernel: mmc1: new high speed SDIO card at address 0001
Jan 28 22:55:54 sibermusic kernel: mmc0: new ultra high speed DDR50 SDHC card at address 0007
Jan 28 22:55:54 sibermusic kernel: mmcblk0: mmc0:0007 SD8GB 7.42 GiB
Jan 28 22:55:54 sibermusic kernel: mmcblk0: p1 p2 p3
Jan 28 22:55:54 sibermusic kernel: mmcblk0: mmc0:0007 SD8GB 7.42 GiB
Jan 28 22:55:54 sibermusic kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd
Jan 28 22:55:54 sibermusic initramfs: Booting Volumio for BCM2711
Jan 28 22:55:54 sibermusic initramfs: This script mounts rootfs RO with an overlay RW layer.
Jan 28 22:55:54 sibermusic kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Jan 28 22:55:54 sibermusic initramfs: IMGPART=/dev/mmcblk0p2
Jan 28 22:55:54 sibermusic initramfs: IMGFILE=/volumio_current.sqsh
Jan 28 22:55:54 sibermusic initramfs: Boot delay (except first time) will be 5 seconds
Jan 28 22:55:54 sibermusic initramfs: /dev/mmcblk0p2:
Jan 28 22:55:54 sibermusic kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
Jan 28 22:55:54 sibermusic kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Jan 28 22:55:54 sibermusic kernel: usb 1-1: Product: USB2.0 Hub
Jan 28 22:55:54 sibermusic kernel: hub 1-1:1.0: USB hub found
Jan 28 22:55:54 sibermusic kernel: hub 1-1:1.0: 4 ports detected
Jan 28 22:55:54 sibermusic kernel: usb 1-1.2: new high-speed USB device number 3 using xhci_hcd
Jan 28 22:55:54 sibermusic kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 1.04
Jan 28 22:55:54 sibermusic kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0
Jan 28 22:55:54 sibermusic kernel: usb 1-1.2: Product: D10s
Jan 28 22:55:54 sibermusic kernel: usb 1-1.2: Manufacturer: Topping
Jan 28 22:55:54 sibermusic kernel: EXT4-fs (mmcblk0p2): recovery complete
Jan 28 22:55:54 sibermusic kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none.
Jan 28 22:55:54 sibermusic initramfs: Doing a 5 second delay here to give kernel load a headstart
Jan 28 22:55:54 sibermusic initramfs: Checking for USB updates
Jan 28 22:55:54 sibermusic initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline)
Jan 28 22:55:54 sibermusic kernel: loop0: detected capacity change from 0 to 1001120
Jan 28 22:55:54 sibermusic kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Jan 28 22:55:54 sibermusic kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Jan 28 22:55:54 sibermusic kernel: EXT4-fs (mmcblk0p3): recovery complete
Jan 28 22:55:54 sibermusic kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none.
Jan 28 22:55:54 sibermusic initramfs: With Option:
Jan 28 22:55:54 sibermusic initramfs: VOLUMIO_VERSION="3.601"
Jan 28 22:55:54 sibermusic initramfs: Finish initramfs, continue booting Volumio
Jan 28 22:55:54 sibermusic systemd[1]: System time before build time, advancing clock.
Jan 28 22:55:54 sibermusic kernel: NET: Registered PF_INET6 protocol family
Jan 28 22:55:54 sibermusic kernel: Segment Routing with IPv6
Jan 28 22:55:54 sibermusic kernel: In-situ OAM (IOAM) with IPv6
Jan 28 22:55:54 sibermusic systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
Jan 28 22:55:54 sibermusic systemd[1]: Detected architecture arm.
Jan 28 22:55:54 sibermusic systemd[1]: Set hostname to .
Jan 28 22:55:54 sibermusic systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Jan 28 22:55:54 sibermusic systemd[1]: Listening on fsck to fsckd communication Socket.
Jan 28 22:55:54 sibermusic systemd[1]: Listening on Journal Socket (/dev/log).
Jan 28 22:55:54 sibermusic systemd[1]: Listening on udev Kernel Socket.
Jan 28 22:55:54 sibermusic systemd[1]: Created slice system-getty.slice.
Jan 28 22:55:54 sibermusic systemd[1]: Listening on Journal Socket.
Jan 28 22:55:54 sibermusic systemd[1]: Mounting Kernel Debug File System...
Jan 28 22:55:54 sibermusic kernel: i2c_dev: i2c /dev entries driver
Jan 28 22:55:54 sibermusic systemd-journald[207]: Journal started
Jan 28 22:55:54 sibermusic systemd-journald[207]: Runtime journal (/run/log/journal/4ceeebcde4a5f04b591e77826532825c) is 3.7M, max 30.0M, 26.2M free.
Jan 28 22:55:54 sibermusic systemd-modules-load[197]: Inserted module 'i2c_dev'
Jan 28 22:55:54 sibermusic fake-hwclock[199]: Sun Jan 28 21:55:54 UTC 2024
Jan 28 22:55:54 sibermusic systemd[1]: dynamicswap.service: Succeeded.
Jan 28 22:55:54 sibermusic systemd[1]: Started Remount Root and Kernel File Systems.
Jan 28 22:55:54 sibermusic systemd[1]: Started Apply Kernel Variables.
Jan 28 22:55:54 sibermusic systemd[1]: Starting Create System Users...
Jan 28 22:55:54 sibermusic systemd[1]: Starting Load/Save Random Seed...
Jan 28 22:55:54 sibermusic systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Jan 28 22:55:54 sibermusic systemd[1]: Started Load/Save Random Seed.
Jan 28 22:55:54 sibermusic systemd[1]: Started Create System Users.
Jan 28 22:55:54 sibermusic systemd[1]: Starting Create Static Device Nodes in /dev...
Jan 28 22:55:54 sibermusic systemd[1]: Started udev Coldplug all Devices.
Jan 28 22:55:54 sibermusic systemd[1]: Starting Helper to synchronize boot up for ifupdown...
Jan 28 22:55:54 sibermusic systemd[1]: Started Create Static Device Nodes in /dev.
Jan 28 22:55:54 sibermusic systemd[1]: Starting udev Kernel Device Manager...
Jan 28 22:55:54 sibermusic systemd[1]: Reached target Local File Systems (Pre).
Jan 28 22:55:54 sibermusic systemd[1]: Mounting /var/spool/cups...
Jan 28 22:55:54 sibermusic systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
Jan 28 22:55:54 sibermusic systemd[1]: Mounting /tmp...
Jan 28 22:55:54 sibermusic systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway.
Jan 28 22:55:54 sibermusic systemd[1]: Mounting /var/log...
Jan 28 22:55:54 sibermusic systemd[1]: Started Helper to synchronize boot up for ifupdown.
Jan 28 22:55:54 sibermusic systemd[1]: Mounted /var/spool/cups.
Jan 28 22:55:54 sibermusic systemd[1]: Mounted /tmp.
Jan 28 22:55:54 sibermusic systemd[1]: Mounted /var/log.
Jan 28 22:55:54 sibermusic systemd[1]: Starting Flush Journal to Persistent Storage...
Jan 28 22:55:54 sibermusic systemd-udevd[231]: Network interface NamePolicy= disabled on kernel command line, ignoring.
Jan 28 22:55:54 sibermusic systemd[1]: Mounting /var/spool/cups/tmp...
Jan 28 22:55:54 sibermusic systemd[1]: Mounted /var/spool/cups/tmp.
Jan 28 22:55:54 sibermusic systemd-journald[207]: Runtime journal (/run/log/journal/4ceeebcde4a5f04b591e77826532825c) is 3.7M, max 30.0M, 26.2M free.
Jan 28 22:55:54 sibermusic systemd[1]: Started Flush Journal to Persistent Storage.
Jan 28 22:55:54 sibermusic systemd[1]: Started udev Kernel Device Manager.
Jan 28 22:55:54 sibermusic systemd[1]: Starting Show Plymouth Boot Screen...
Jan 28 22:55:54 sibermusic systemd[1]: Received SIGRTMIN+20 from PID 257 (plymouthd).
Jan 28 22:55:54 sibermusic systemd[1]: Started Show Plymouth Boot Screen.
Jan 28 22:55:54 sibermusic systemd[1]: Started Forward Password Requests to Plymouth Directory Watch.
Jan 28 22:55:54 sibermusic systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Jan 28 22:55:54 sibermusic systemd[1]: Reached target Local Encrypted Volumes.
Jan 28 22:55:54 sibermusic systemd[1]: Reached target Paths.
Jan 28 22:55:54 sibermusic systemd-udevd[252]: Using default interface naming scheme 'v240'.
Jan 28 22:55:54 sibermusic systemd-udevd[252]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jan 28 22:55:54 sibermusic kernel: mc: Linux media interface: v0.10
Jan 28 22:55:54 sibermusic kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Jan 28 22:55:55 sibermusic kernel: rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000
Jan 28 22:55:55 sibermusic kernel: rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem
Jan 28 22:55:55 sibermusic kernel: videodev: Linux video capture interface: v2.00
Jan 28 22:55:55 sibermusic kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Jan 28 22:55:55 sibermusic kernel: [vc_sm_connected_init]: start
Jan 28 22:55:55 sibermusic kernel: [vc_sm_connected_init]: installed successfully
Jan 28 22:55:55 sibermusic kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Jan 28 22:55:55 sibermusic kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Jan 28 22:55:55 sibermusic kernel: input: raspberrypi-ts as /devices/platform/soc/soc:firmware/soc:firmware:touchscreen/input/input0
Jan 28 22:55:55 sibermusic kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Jan 28 22:55:55 sibermusic kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Jan 28 22:55:55 sibermusic kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Jan 28 22:55:55 sibermusic kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned.
Jan 28 22:55:55 sibermusic kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Jan 28 22:55:55 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Jan 28 22:55:55 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Jan 28 22:55:55 sibermusic kernel: rpivid feb10000.codec: Device registered as /dev/video19
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Jan 28 22:55:55 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Jan 28 22:55:55 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Jan 28 22:55:55 sibermusic kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
Jan 28 22:55:55 sibermusic systemd-udevd[244]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jan 28 22:55:55 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Jan 28 22:55:55 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Jan 28 22:55:55 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18
Jan 28 22:55:55 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
Jan 28 22:55:55 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31
Jan 28 22:55:55 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image
Jan 28 22:55:55 sibermusic kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Jan 28 22:55:55 sibermusic kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf'
Jan 28 22:55:55 sibermusic kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328'
Jan 28 22:55:55 sibermusic kernel: cfg80211: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
Jan 28 22:55:55 sibermusic kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Jan 28 22:55:56 sibermusic kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Jan 28 22:55:56 sibermusic kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored
Jan 28 22:55:56 sibermusic kernel: bcm2835_audio bcm2835_audio: card created with 8 channels
Jan 28 22:55:56 sibermusic kernel: Bluetooth: Core ver 2.22
Jan 28 22:55:56 sibermusic kernel: NET: Registered PF_BLUETOOTH protocol family
Jan 28 22:55:56 sibermusic kernel: Bluetooth: HCI device and connection manager initialized
Jan 28 22:55:56 sibermusic kernel: Bluetooth: HCI socket layer initialized
Jan 28 22:55:56 sibermusic kernel: Bluetooth: L2CAP socket layer initialized
Jan 28 22:55:56 sibermusic kernel: Bluetooth: SCO socket layer initialized
Jan 28 22:55:56 sibermusic kernel: brcmfmac: F1 signature read @0x18000000=0x15264345
Jan 28 22:55:56 sibermusic kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan 28 22:55:56 sibermusic kernel: usbcore: registered new interface driver brcmfmac
Jan 28 22:55:56 sibermusic kernel: Bluetooth: HCI UART driver ver 2.3
Jan 28 22:55:56 sibermusic kernel: Bluetooth: HCI UART protocol H4 registered
Jan 28 22:55:56 sibermusic kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered
Jan 28 22:55:56 sibermusic kernel: Bluetooth: HCI UART protocol Broadcom registered
Jan 28 22:55:56 sibermusic kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator
Jan 28 22:55:56 sibermusic kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator
Jan 28 22:55:56 sibermusic kernel: uart-pl011 fe201000.serial: no DMA platform data
Jan 28 22:55:56 sibermusic systemd[1]: Found device /dev/mmcblk0p1.
Jan 28 22:55:56 sibermusic kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60
Jan 28 22:55:56 sibermusic kernel: Bluetooth: hci0: BCM: chip id 107
Jan 28 22:55:56 sibermusic kernel: Bluetooth: hci0: BCM: features 0x2f
Jan 28 22:55:56 sibermusic kernel: Bluetooth: hci0: BCM4345C0
Jan 28 22:55:56 sibermusic kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000
Jan 28 22:55:56 sibermusic systemd-udevd[238]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jan 28 22:55:56 sibermusic kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch
Jan 28 22:55:56 sibermusic systemd-udevd[238]: Using default interface naming scheme 'v240'.
Jan 28 22:55:56 sibermusic systemd-udevd[238]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jan 28 22:55:56 sibermusic kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000
Jan 28 22:55:56 sibermusic kernel: usbcore: registered new interface driver snd-usb-audio
Jan 28 22:55:56 sibermusic systemd-udevd[245]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jan 28 22:55:57 sibermusic kernel: Bluetooth: hci0: BCM: features 0x2f
Jan 28 22:55:57 sibermusic kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+
Jan 28 22:55:57 sibermusic kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342
Jan 28 22:55:58 sibermusic systemd-udevd[254]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7.
Jan 28 22:55:58 sibermusic systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped.
Jan 28 22:55:58 sibermusic systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped.
Jan 28 22:55:58 sibermusic systemd[1]: Created slice system-bthelper.slice.
Jan 28 22:55:58 sibermusic systemd[1]: Condition check resulted in FUSE Control File System being skipped.
Jan 28 22:55:58 sibermusic systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Jan 28 22:55:58 sibermusic systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Jan 28 22:55:58 sibermusic systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Jan 28 22:55:58 sibermusic systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Jan 28 22:55:58 sibermusic systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Jan 28 22:55:58 sibermusic systemd[1]: Created slice system-systemd\x2dbacklight.slice.
Jan 28 22:55:58 sibermusic systemd[1]: Starting Load/Save Screen Backlight Brightness of backlight:rpi_backlight...
Jan 28 22:55:58 sibermusic systemd[1]: Starting File System Check on /dev/mmcblk0p1...
Jan 28 22:55:58 sibermusic systemd[1]: Starting Load/Save RF Kill Switch Status...
Jan 28 22:55:58 sibermusic systemd[1]: Started Load/Save Screen Backlight Brightness of backlight:rpi_backlight.
Jan 28 22:55:58 sibermusic systemd[1]: Started File System Check Daemon to report status.
Jan 28 22:55:58 sibermusic systemd[1]: Started Load/Save RF Kill Switch Status.
Jan 28 22:55:58 sibermusic systemd-fsck[396]: fsck.fat 4.1 (2017-01-24)
Jan 28 22:55:58 sibermusic systemd-fsck[396]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
Jan 28 22:55:58 sibermusic systemd-fsck[396]: Automatically removing dirty bit.
Jan 28 22:55:58 sibermusic systemd-fsck[396]: Performing changes.
Jan 28 22:55:58 sibermusic systemd-fsck[396]: /dev/mmcblk0p1: 367 files, 33302/46774 clusters
Jan 28 22:55:58 sibermusic systemd[1]: Started File System Check on /dev/mmcblk0p1.
Jan 28 22:55:58 sibermusic systemd[1]: Mounting /boot...
Jan 28 22:55:58 sibermusic systemd[1]: Mounted /boot.
Jan 28 22:55:58 sibermusic systemd[1]: Reached target Local File Systems.
Jan 28 22:55:58 sibermusic systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Jan 28 22:55:58 sibermusic systemd[1]: Started ifup for eth0.
Jan 28 22:55:58 sibermusic systemd[1]: Starting Raise network interfaces...
Jan 28 22:55:58 sibermusic systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Jan 28 22:55:59 sibermusic systemd[1]: Started ifup for wlan0.
Jan 28 22:55:59 sibermusic systemd[1]: Starting Create Volatile Files and Directories...
Jan 28 22:55:59 sibermusic systemd[1]: Starting Preprocess NFS configuration...
Jan 28 22:55:59 sibermusic systemd[1]: plymouth-read-write.service: Succeeded.
Jan 28 22:55:59 sibermusic systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Jan 28 22:55:59 sibermusic systemd[1]: Received SIGRTMIN+20 from PID 257 (plymouthd).
Jan 28 22:55:59 sibermusic systemd[1]: nfs-config.service: Succeeded.
Jan 28 22:55:59 sibermusic systemd[1]: Started Preprocess NFS configuration.
Jan 28 22:55:59 sibermusic systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Jan 28 22:55:59 sibermusic systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Jan 28 22:55:59 sibermusic systemd[1]: Reached target NFS client services.
Jan 28 22:55:59 sibermusic systemd[1]: Started Create Volatile Files and Directories.
Jan 28 22:55:59 sibermusic systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Jan 28 22:55:59 sibermusic systemd[1]: Condition check resulted in Network Time Synchronization being skipped.
Jan 28 22:55:59 sibermusic systemd[1]: Starting RPC bind portmap service...
Jan 28 22:55:59 sibermusic systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Jan 28 22:55:59 sibermusic systemd[1]: Started Update UTMP about System Boot/Shutdown.
Jan 28 22:55:59 sibermusic systemd[1]: Reached target System Initialization.
Jan 28 22:55:59 sibermusic systemd[1]: Started Daily Cleanup of Temporary Directories.
Jan 28 22:55:59 sibermusic kernel: 8021q: 802.1Q VLAN Support v1.8
Jan 28 22:55:59 sibermusic systemd[1]: apt-daily.timer: Not using persistent file timestamp Tue 2024-01-30 11:56:17 CET as it is in the future.
Jan 28 22:55:59 sibermusic systemd[1]: Started Daily apt download activities.
Jan 28 22:55:59 sibermusic systemd[1]: Listening on lircd.socket.
Jan 28 22:55:59 sibermusic systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Jan 28 22:55:59 sibermusic systemd[1]: Listening on triggerhappy.socket.
Jan 28 22:55:59 sibermusic kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Jan 28 22:55:59 sibermusic systemd[1]: Listening on D-Bus System Message Bus Socket.
Jan 28 22:55:59 sibermusic systemd[1]: Reached target Sockets.
Jan 28 22:55:59 sibermusic systemd[1]: Reached target Basic System.
Jan 28 22:55:59 sibermusic systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Jan 28 22:55:59 sibermusic systemd[1]: Started D-Bus System Message Bus.
Jan 28 22:55:59 sibermusic systemd[1]: Starting Configure Bluetooth Modems connected by UART...
Jan 28 22:55:59 sibermusic systemd[1]: Starting Login Service...
Jan 28 22:55:59 sibermusic systemd[1]: Starting triggerhappy global hotkey daemon...
Jan 28 22:55:59 sibermusic systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Jan 28 22:55:59 sibermusic systemd[1]: Starting Wireless Services...
Jan 28 22:55:59 sibermusic systemd[1]: Started Manage Sound Card State (restore and store).
Jan 28 22:55:59 sibermusic systemd[1]: Starting Save/Restore Sound Card State...
Jan 28 22:55:59 sibermusic systemd[1]: Started UPnP Renderer front-end to MPD.
Jan 28 22:55:59 sibermusic alsactl[523]: alsactl 1.1.8 daemon started
Jan 28 22:55:59 sibermusic systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Jan 28 22:55:59 sibermusic systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Jan 28 22:55:59 sibermusic systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Tue 2024-01-30 06:12:01 CET as it is in the future.
Jan 28 22:55:59 sibermusic systemd[1]: Started Daily apt upgrade and clean activities.
Jan 28 22:55:59 sibermusic systemd[1]: Starting WPA supplicant...
Jan 28 22:55:59 sibermusic systemd[1]: man-db.timer: Not using persistent file timestamp Tue 2024-01-30 00:01:07 CET as it is in the future.
Jan 28 22:55:59 sibermusic systemd[1]: Started Daily man-db regeneration.
Jan 28 22:55:59 sibermusic systemd[1]: Reached target Timers.
Jan 28 22:55:59 sibermusic systemd[1]: Started volumio-remote-updater.service.
Jan 28 22:55:59 sibermusic systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Jan 28 22:55:59 sibermusic systemd[1]: Starting dhcpcd on all interfaces...
Jan 28 22:55:59 sibermusic systemd[1]: Started Volumio Iptables Module.
Jan 28 22:55:59 sibermusic systemd[1]: Started RPC bind portmap service.
Jan 28 22:55:59 sibermusic systemd[1]: hciuart.service: Succeeded.
Jan 28 22:55:59 sibermusic systemd[1]: Started Configure Bluetooth Modems connected by UART.
Jan 28 22:55:59 sibermusic systemd[1]: Starting Raspberry Pi bluetooth helper...
Jan 28 22:55:59 sibermusic systemd[1]: Reached target Remote File Systems (Pre).
Jan 28 22:55:59 sibermusic systemd[1]: Reached target Remote File Systems.
Jan 28 22:55:59 sibermusic systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Jan 28 22:55:59 sibermusic systemd[1]: Reached target RPC Port Mapper.
Jan 28 22:56:00 sibermusic sh[408]: wlan0=wlan0
Jan 28 22:56:00 sibermusic dhcpcd[531]: Not running dhcpcd because /etc/network/interfaces
Jan 28 22:56:00 sibermusic dhcpcd[531]: defines some interfaces that will use a
Jan 28 22:56:00 sibermusic dhcpcd[531]: DHCP client or static address
Jan 28 22:56:00 sibermusic thd[513]: Unable to parse trigger line:
Jan 28 22:56:00 sibermusic thd[513]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Jan 28 22:56:00 sibermusic thd[513]: Unable to parse trigger line:
Jan 28 22:56:00 sibermusic thd[513]: Found socket passed from systemd
Jan 28 22:56:00 sibermusic sh[405]: eth0: waiting for carrier
Jan 28 22:56:00 sibermusic dhcpcd[455]: eth0: waiting for carrier
Jan 28 22:56:00 sibermusic kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
Jan 28 22:56:00 sibermusic kernel: bcmgenet fd580000.ethernet eth0: Link is Down
Jan 28 22:56:00 sibermusic systemd-logind[507]: New seat seat0.
Jan 28 22:56:00 sibermusic bthelper[533]: Raspberry Pi BDADDR already set
Jan 28 22:56:00 sibermusic avahi-daemon[528]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113).
Jan 28 22:56:00 sibermusic avahi-daemon[528]: Successfully dropped root privileges.
Jan 28 22:56:00 sibermusic avahi-daemon[528]: avahi-daemon 0.7 starting up.
Jan 28 22:56:00 sibermusic volumio-remote-updater[530]: Error: No active session
Jan 28 22:56:00 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:00] [info] asio async_connect error: system:111 (Connection refused)
Jan 28 22:56:00 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Jan 28 22:56:00 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:00] [error] handle_connect error: Underlying Transport Error
Jan 28 22:56:00 sibermusic systemd[1]: Started Login Service.
Jan 28 22:56:00 sibermusic systemd[1]: Started triggerhappy global hotkey daemon.
Jan 28 22:56:00 sibermusic systemd[1]: Started Save/Restore Sound Card State.
Jan 28 22:56:00 sibermusic systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED
Jan 28 22:56:00 sibermusic systemd[1]: dhcpcd.service: Failed with result 'exit-code'.
Jan 28 22:56:00 sibermusic systemd[1]: Failed to start dhcpcd on all interfaces.
Jan 28 22:56:00 sibermusic avahi-daemon[528]: Successfully called chroot().
Jan 28 22:56:00 sibermusic avahi-daemon[528]: Successfully dropped remaining capabilities.
Jan 28 22:56:00 sibermusic systemd[1]: Started Raspberry Pi bluetooth helper.
Jan 28 22:56:00 sibermusic avahi-daemon[528]: Loading service file /services/volumio.service.
Jan 28 22:56:00 sibermusic wpa_supplicant[529]: Successfully initialized wpa_supplicant
Jan 28 22:56:00 sibermusic avahi-daemon[528]: Network interface enumeration completed.
Jan 28 22:56:00 sibermusic avahi-daemon[528]: Server startup complete. Host name is sibermusic.local. Local service cookie is 1427307831.
Jan 28 22:56:00 sibermusic avahi-daemon[528]: Service "sibermusic" (/services/volumio.service) successfully established.
Jan 28 22:56:00 sibermusic systemd[1]: Started Raise network interfaces.
Jan 28 22:56:01 sibermusic volumio[526]: Could not open config: /tmp/upmpdcli.conf
Jan 28 22:56:01 sibermusic systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Jan 28 22:56:01 sibermusic systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Jan 28 22:56:01 sibermusic systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Jan 28 22:56:01 sibermusic systemd[1]: Started WPA supplicant.
Jan 28 22:56:01 sibermusic systemd[1]: Starting Bluetooth service...
Jan 28 22:56:01 sibermusic systemd[1]: Reached target Network.
Jan 28 22:56:01 sibermusic systemd[1]: Starting Network Time Service...
Jan 28 22:56:01 sibermusic systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Jan 28 22:56:01 sibermusic systemd[1]: Reached target Network is Online.
Jan 28 22:56:01 sibermusic systemd[1]: Starting /etc/rc.local Compatibility...
Jan 28 22:56:01 sibermusic systemd[1]: Starting LSB: Brings up/down network automatically...
Jan 28 22:56:01 sibermusic systemd[1]: Starting Permit User Sessions...
Jan 28 22:56:01 sibermusic systemd[1]: Starting OpenBSD Secure Shell server...
Jan 28 22:56:01 sibermusic systemd[1]: Starting Samba NMB Daemon...
Jan 28 22:56:01 sibermusic systemd[1]: Reached target Sound Card.
Jan 28 22:56:01 sibermusic systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 28 22:56:01 sibermusic systemd[1]: Started Permit User Sessions.
Jan 28 22:56:01 sibermusic bluetoothd[590]: Bluetooth daemon 5.50
Jan 28 22:56:01 sibermusic loadcpufreq[534]: Loading cpufreq kernel modules...done (none).
Jan 28 22:56:01 sibermusic systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Jan 28 22:56:01 sibermusic bluetoothd[590]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Jan 28 22:56:01 sibermusic systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Jan 28 22:56:01 sibermusic systemd[1]: Started Bluetooth service.
Jan 28 22:56:01 sibermusic systemd[1]: Reached target Bluetooth.
Jan 28 22:56:01 sibermusic bluetoothd[590]: Starting SDP server
Jan 28 22:56:01 sibermusic bluetoothd[590]: Excluding (cli) sap
Jan 28 22:56:01 sibermusic ifplugd(eth0)[649]: ifplugd 0.28 initializing.
Jan 28 22:56:01 sibermusic ifplugd(eth0)[649]: Using interface eth0/DC:A6:32:6C:7A:FC with driver (version: 6.1.70-v7l+)
Jan 28 22:56:01 sibermusic ifplugd(eth0)[649]: Using detection mode: SIOCETHTOOL
Jan 28 22:56:01 sibermusic ifplugd(eth0)[649]: Initialization complete, link beat not detected.
Jan 28 22:56:01 sibermusic ifplugd[597]: Network Interface Plugging Daemon...start eth0...done.
Jan 28 22:56:01 sibermusic ntpd[595]: ntpd 4.2.8p12@1.3728-o (1): Starting
Jan 28 22:56:01 sibermusic ntpd[595]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
Jan 28 22:56:01 sibermusic ntpd[654]: proto: precision = 1.981 usec (-19)
Jan 28 22:56:01 sibermusic systemd[1]: Started Network Time Service.
Jan 28 22:56:01 sibermusic systemd[1]: Started LSB: Brings up/down network automatically.
Jan 28 22:56:01 sibermusic ntpd[654]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Jan 28 22:56:01 sibermusic ntpd[654]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Jan 28 22:56:01 sibermusic ntpd[654]: Listen and drop on 0 v6wildcard [::]:123
Jan 28 22:56:01 sibermusic ntpd[654]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Jan 28 22:56:01 sibermusic ntpd[654]: Listen normally on 2 lo 127.0.0.1:123
Jan 28 22:56:01 sibermusic ntpd[654]: Listening on routing socket on fd #19 for interface updates
Jan 28 22:56:01 sibermusic ntpd[654]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jan 28 22:56:01 sibermusic ntpd[654]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jan 28 22:56:01 sibermusic systemd[1]: iptables.service: Succeeded.
Jan 28 22:56:01 sibermusic kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Jan 28 22:56:01 sibermusic kernel: Bluetooth: BNEP filters: protocol multicast
Jan 28 22:56:01 sibermusic kernel: Bluetooth: BNEP socket layer initialized
Jan 28 22:56:01 sibermusic bluetoothd[590]: Bluetooth management interface 1.22 initialized
Jan 28 22:56:01 sibermusic dbus-daemon[483]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=590 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Jan 28 22:56:01 sibermusic sshd[652]: Server listening on 0.0.0.0 port 22.
Jan 28 22:56:01 sibermusic sshd[652]: Server listening on :: port 22.
Jan 28 22:56:02 sibermusic kernel: Bluetooth: MGMT ver 1.22
Jan 28 22:56:02 sibermusic cpufrequtils[636]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done.
Jan 28 22:56:02 sibermusic bluetoothd[590]: Failed to set privacy: Rejected (0x0b)
Jan 28 22:56:02 sibermusic sudo[604]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh -c echo 0 > /sys/class/leds/PWR/brightness
Jan 28 22:56:02 sibermusic sudo[604]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:02 sibermusic systemd[1]: Started OpenBSD Secure Shell server.
Jan 28 22:56:02 sibermusic systemd[1]: Started LSB: set CPUFreq kernel parameters.
Jan 28 22:56:02 sibermusic sudo[604]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:02 sibermusic systemd[1]: Starting Hostname Service...
Jan 28 22:56:02 sibermusic systemd[1]: Started /etc/rc.local Compatibility.
Jan 28 22:56:02 sibermusic systemd[1]: Starting Terminate Plymouth Boot Screen...
Jan 28 22:56:02 sibermusic systemd[1]: Starting Hold until boot process finishes up...
Jan 28 22:56:02 sibermusic systemd[1]: Received SIGRTMIN+21 from PID 257 (plymouthd).
Jan 28 22:56:02 sibermusic systemd[1]: Received SIGRTMIN+21 from PID 257 (plymouthd).
Jan 28 22:56:02 sibermusic systemd[1]: plymouth-quit.service: Succeeded.
Jan 28 22:56:02 sibermusic systemd[1]: Started Terminate Plymouth Boot Screen.
Jan 28 22:56:02 sibermusic systemd[1]: plymouth-start.service: Succeeded.
Jan 28 22:56:02 sibermusic systemd[1]: plymouth-quit-wait.service: Succeeded.
Jan 28 22:56:02 sibermusic systemd[1]: Started Hold until boot process finishes up.
Jan 28 22:56:02 sibermusic systemd[1]: Started Getty on tty1.
Jan 28 22:56:02 sibermusic systemd[1]: Reached target Login Prompts.
Jan 28 22:56:02 sibermusic dbus-daemon[483]: [system] Successfully activated service 'org.freedesktop.hostname1'
Jan 28 22:56:02 sibermusic systemd[1]: Started Hostname Service.
Jan 28 22:56:02 sibermusic haveged[443]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K
Jan 28 22:56:02 sibermusic haveged[443]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488
Jan 28 22:56:02 sibermusic haveged[443]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99827
Jan 28 22:56:02 sibermusic haveged[443]: haveged: fills: 0, generated: 0
Jan 28 22:56:02 sibermusic ntpd[654]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Jan 28 22:56:02 sibermusic kernel: new mount options do not match the existing superblock, will be ignored
Jan 28 22:56:02 sibermusic nmbd[626]: [2024/01/28 22:56:02.936584, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Jan 28 22:56:02 sibermusic nmbd[626]: started asyncdns process 682
Jan 28 22:56:02 sibermusic nmbd[626]: [2024/01/28 22:56:02.938567, 0] ../lib/util/become_daemon.c:149(daemon_status)
Jan 28 22:56:02 sibermusic nmbd[626]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Jan 28 22:56:02 sibermusic nmbd[626]: [2024/01/28 22:56:02.938709, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Jan 28 22:56:02 sibermusic nmbd[626]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Jan 28 22:56:03 sibermusic wireless.js[518]: Cleaning previous...
Jan 28 22:56:03 sibermusic volumio[515]: cset: --> shielding system active with
Jan 28 22:56:03 sibermusic volumio[515]: cset: "system" cpuset of CPUSPEC(2-3) with 75 tasks running
Jan 28 22:56:03 sibermusic volumio[515]: cset: "user" cpuset of CPUSPEC(0-1) with 0 tasks running
Jan 28 22:56:03 sibermusic systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Jan 28 22:56:03 sibermusic sudo[700]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Jan 28 22:56:03 sibermusic sudo[700]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:03 sibermusic sudo[700]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:03 sibermusic sudo[702]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Jan 28 22:56:03 sibermusic sudo[702]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:03 sibermusic systemd[1]: systemd-rfkill.service: Succeeded.
Jan 28 22:56:03 sibermusic sudo[702]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:03 sibermusic wireless.js[518]: Stopped aP
Jan 28 22:56:03 sibermusic ntpd[654]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Jan 28 22:56:03 sibermusic sudo[709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Jan 28 22:56:03 sibermusic sudo[709]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:03 sibermusic sudo[709]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:03 sibermusic kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Jan 28 22:56:03 sibermusic sudo[711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Jan 28 22:56:03 sibermusic sudo[711]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:03 sibermusic sudo[711]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:03 sibermusic sudo[718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Jan 28 22:56:03 sibermusic sudo[718]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:03 sibermusic sudo[718]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:03 sibermusic sudo[720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Jan 28 22:56:03 sibermusic sudo[720]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:04 sibermusic ntpd[654]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Jan 28 22:56:05 sibermusic bthelper[533]: Changing power off succeeded
Jan 28 22:56:05 sibermusic bthelper[533]: [CHG] Controller DC:A6:32:6C:7A:FE Class: 0x0000041c
Jan 28 22:56:05 sibermusic bthelper[533]: Changing power on succeeded
Jan 28 22:56:05 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:05] [info] asio async_connect error: system:111 (Connection refused)
Jan 28 22:56:05 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:05] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Jan 28 22:56:05 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:05] [error] handle_connect error: Underlying Transport Error
Jan 28 22:56:05 sibermusic ntpd[654]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Jan 28 22:56:06 sibermusic sudo[720]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:06 sibermusic wireless.js[518]: SETTING APPROPRIATE REG DOMAIN: EU
Jan 28 22:56:06 sibermusic sudo[731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Jan 28 22:56:06 sibermusic sudo[731]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:06 sibermusic sudo[731]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:06 sibermusic sudo[733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set EU
Jan 28 22:56:06 sibermusic sudo[733]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:06 sibermusic sudo[733]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:06 sibermusic wireless.js[518]: SUCCESSFULLY SET NEW REGDOMAIN: EU
Jan 28 22:56:06 sibermusic wireless.js[518]: Start wireless flow
Jan 28 22:56:06 sibermusic wireless.js[518]: Stopped hotspot (if there)..
Jan 28 22:56:06 sibermusic systemd-udevd[238]: Process '/sbin/crda' failed with exit code 255.
Jan 28 22:56:06 sibermusic sudo[739]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Jan 28 22:56:06 sibermusic sudo[739]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:06 sibermusic sudo[739]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:06 sibermusic sudo[741]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Jan 28 22:56:06 sibermusic sudo[741]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:07 sibermusic sudo[741]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:07 sibermusic wireless.js[518]: DHCP IP
Jan 28 22:56:07 sibermusic wireless.js[518]: Start ap
Jan 28 22:56:07 sibermusic wpa_supplicant[743]: Successfully initialized wpa_supplicant
Jan 28 22:56:07 sibermusic sudo[744]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Jan 28 22:56:07 sibermusic sudo[744]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:07 sibermusic kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Jan 28 22:56:07 sibermusic dhcpcd[745]: dev: loaded udev
Jan 28 22:56:07 sibermusic dhcpcd-run-hooks[763]: wlan0: starting wpa_supplicant
Jan 28 22:56:07 sibermusic dhcpcd-run-hooks[768]: wlan0: failed to start wpa_supplicant
Jan 28 22:56:07 sibermusic dhcpcd-run-hooks[769]: 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
Jan 28 22:56:07 sibermusic dhcpcd[745]: wlan0: connected to Access Point `'
Jan 28 22:56:07 sibermusic dhcpcd[745]: no interfaces have a carrier
Jan 28 22:56:07 sibermusic dhcpcd[745]: forked to background, child pid 779
Jan 28 22:56:07 sibermusic dhcpcd[779]: eth0: waiting for carrier
Jan 28 22:56:07 sibermusic dhcpcd[779]: wlan0: waiting for carrier
Jan 28 22:56:07 sibermusic sudo[744]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:08 sibermusic wireless.js[518]: trying...
Jan 28 22:56:08 sibermusic sudo[781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 28 22:56:08 sibermusic sudo[781]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:08 sibermusic sudo[781]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:09 sibermusic wireless.js[518]: trying...
Jan 28 22:56:09 sibermusic sudo[784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 28 22:56:09 sibermusic sudo[784]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:09 sibermusic sudo[784]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:09 sibermusic wpa_supplicant[767]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Jan 28 22:56:09 sibermusic wpa_supplicant[767]: wlan0: Trying to associate with SSID 'Ziggy'
Jan 28 22:56:10 sibermusic wireless.js[518]: trying...
Jan 28 22:56:10 sibermusic sudo[787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 28 22:56:10 sibermusic sudo[787]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:10 sibermusic sudo[787]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:11 sibermusic wireless.js[518]: trying...
Jan 28 22:56:11 sibermusic sudo[790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 28 22:56:11 sibermusic sudo[790]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:11 sibermusic sudo[790]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:12 sibermusic wireless.js[518]: trying...
Jan 28 22:56:12 sibermusic sudo[793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 28 22:56:12 sibermusic sudo[793]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:12 sibermusic sudo[793]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:12 sibermusic dhcpcd[779]: wlan0: carrier acquired
Jan 28 22:56:12 sibermusic dhcpcd[779]: wlan0: connected to Access Point `Ziggy'
Jan 28 22:56:12 sibermusic wpa_supplicant[767]: wlan0: Associated with ac:22:05:46:79:f1
Jan 28 22:56:12 sibermusic wpa_supplicant[767]: wlan0: CTRL-EVENT-CONNECTED - Connection to ac:22:05:46:79:f1 completed [id=0 id_str=]
Jan 28 22:56:12 sibermusic wpa_supplicant[767]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Jan 28 22:56:12 sibermusic dhcpcd[779]: DUID 00:01:00:01:2c:c5:41:6b:e4:5f:01:7c:b5:70
Jan 28 22:56:12 sibermusic dhcpcd[779]: wlan0: IAID 32:6c:7a:fd
Jan 28 22:56:12 sibermusic dhcpcd[779]: wlan0: adding address fe80::fcef:8611:26df:870e
Jan 28 22:56:12 sibermusic dhcpcd[779]: ipv6_addaddr1: Permission denied
Jan 28 22:56:12 sibermusic dhcpcd[779]: wlan0: carrier lost
Jan 28 22:56:12 sibermusic systemd-udevd[796]: Process '/sbin/crda' failed with exit code 255.
Jan 28 22:56:12 sibermusic dhcpcd[779]: wlan0: carrier acquired
Jan 28 22:56:12 sibermusic dhcpcd[779]: wlan0: IAID 32:6c:7a:fd
Jan 28 22:56:13 sibermusic dhcpcd[779]: wlan0: rebinding lease of 192.168.178.227
Jan 28 22:56:13 sibermusic wireless.js[518]: trying...
Jan 28 22:56:13 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:13] [info] asio async_connect error: system:111 (Connection refused)
Jan 28 22:56:13 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:13] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Jan 28 22:56:13 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:13] [error] handle_connect error: Underlying Transport Error
Jan 28 22:56:13 sibermusic sudo[810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 28 22:56:13 sibermusic sudo[810]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:13 sibermusic sudo[810]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:13 sibermusic dhcpcd[779]: wlan0: probing address 192.168.178.227/24
Jan 28 22:56:13 sibermusic dhcpcd[779]: wlan0: soliciting an IPv6 router
Jan 28 22:56:14 sibermusic wireless.js[518]: trying...
Jan 28 22:56:14 sibermusic sudo[813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 28 22:56:14 sibermusic sudo[813]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:14 sibermusic sudo[813]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:15 sibermusic wireless.js[518]: trying...
Jan 28 22:56:15 sibermusic sudo[816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 28 22:56:15 sibermusic sudo[816]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:15 sibermusic sudo[816]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:15 sibermusic wpa_supplicant[767]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Jan 28 22:56:16 sibermusic wireless.js[518]: trying...
Jan 28 22:56:16 sibermusic sudo[819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 28 22:56:16 sibermusic sudo[819]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:16 sibermusic sudo[819]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:17 sibermusic wireless.js[518]: trying...
Jan 28 22:56:17 sibermusic sudo[822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 28 22:56:17 sibermusic sudo[822]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:17 sibermusic sudo[822]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:17 sibermusic dhcpcd[779]: wlan0: leased 192.168.178.227 for 604800 seconds
Jan 28 22:56:17 sibermusic avahi-daemon[528]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.227.
Jan 28 22:56:17 sibermusic avahi-daemon[528]: New relevant interface wlan0.IPv4 for mDNS.
Jan 28 22:56:17 sibermusic dhcpcd[779]: wlan0: adding route to 192.168.178.0/24
Jan 28 22:56:17 sibermusic avahi-daemon[528]: Registering new address record for 192.168.178.227 on wlan0.IPv4.
Jan 28 22:56:17 sibermusic dhcpcd[779]: wlan0: adding default route via 192.168.178.1
Jan 28 22:56:17 sibermusic systemd[1]: Started Samba NMB Daemon.
Jan 28 22:56:17 sibermusic nmbd[626]: [2024/01/28 22:56:17.947396, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Jan 28 22:56:17 sibermusic nmbd[626]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Jan 28 22:56:17 sibermusic nmbd[626]: [2024/01/28 22:56:17.969543, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jan 28 22:56:17 sibermusic nmbd[626]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.227 for name WORKGROUP<1d>.
Jan 28 22:56:17 sibermusic nmbd[626]: This response was from IP 192.168.178.80, reporting an IP address of 192.168.178.80.
Jan 28 22:56:18 sibermusic systemd[1]: Starting Samba Winbind Daemon...
Jan 28 22:56:18 sibermusic wireless.js[518]: trying...
Jan 28 22:56:18 sibermusic sudo[848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 28 22:56:18 sibermusic sudo[848]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:18 sibermusic sudo[848]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:18 sibermusic wireless.js[518]: Connected to: ----Ziggy
Jan 28 22:56:18 sibermusic wireless.js[518]: ----
Jan 28 22:56:18 sibermusic sudo[851]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 28 22:56:18 sibermusic sudo[851]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:18 sibermusic sudo[851]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:18 sibermusic wireless.js[518]: ... joined AP, wlan0 IPv4 is 192.168.178.227, ipV6 is undefined
Jan 28 22:56:18 sibermusic wireless.js[518]: It's done! AP
Jan 28 22:56:18 sibermusic winbindd[845]: [2024/01/28 22:56:18.264668, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Jan 28 22:56:18 sibermusic winbindd[845]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Jan 28 22:56:18 sibermusic systemd[1]: Started Samba Winbind Daemon.
Jan 28 22:56:18 sibermusic winbindd[845]: [2024/01/28 22:56:18.309227, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Jan 28 22:56:18 sibermusic winbindd[845]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Jan 28 22:56:18 sibermusic systemd[1]: Starting Samba SMB Daemon...
Jan 28 22:56:18 sibermusic systemd[1]: Started Wireless Services.
Jan 28 22:56:18 sibermusic kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Jan 28 22:56:18 sibermusic systemd[1]: Started Volumio Backend Module.
Jan 28 22:56:18 sibermusic systemd[1]: Started Volumio Cpu Tweaker.
Jan 28 22:56:18 sibermusic volumio-cpu-tweak[860]: Setting RT Priority for mpd
Jan 28 22:56:18 sibermusic volumio-cpu-tweak[860]: pid 35's current scheduling policy: SCHED_OTHER
Jan 28 22:56:18 sibermusic volumio-cpu-tweak[860]: pid 35's current scheduling priority: 0
Jan 28 22:56:18 sibermusic volumio-cpu-tweak[860]: Setting MPD Affinity
Jan 28 22:56:18 sibermusic volumio-cpu-tweak[860]: pid 3's current affinity mask: f
Jan 28 22:56:18 sibermusic volumio-cpu-tweak[860]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input
Jan 28 22:56:18 sibermusic volumio-cpu-tweak[860]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Jan 28 22:56:18 sibermusic systemd[1]: volumio_cpu_tweak.service: Succeeded.
Jan 28 22:56:18 sibermusic winbindd[845]: [2024/01/28 22:56:18.701496, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv)
Jan 28 22:56:18 sibermusic winbindd[845]: res_names->count = 3, expected 4
Jan 28 22:56:18 sibermusic ntpd[654]: Listen normally on 3 wlan0 192.168.178.227:123
Jan 28 22:56:18 sibermusic ntpd[654]: new interface(s) found: waking up resolver
Jan 28 22:56:19 sibermusic smbd[861]: [2024/01/28 22:56:19.765585, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Jan 28 22:56:19 sibermusic systemd[1]: Started Samba SMB Daemon.
Jan 28 22:56:19 sibermusic systemd[1]: Reached target Multi-User System.
Jan 28 22:56:19 sibermusic systemd[1]: Reached target Graphical Interface.
Jan 28 22:56:19 sibermusic smbd[861]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Jan 28 22:56:19 sibermusic systemd[1]: Starting Update UTMP about System Runlevel Changes...
Jan 28 22:56:19 sibermusic systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Jan 28 22:56:19 sibermusic systemd[1]: Started Update UTMP about System Runlevel Changes.
Jan 28 22:56:19 sibermusic systemd[1]: Startup finished in 11.335s (kernel) + 27.475s (userspace) = 38.811s.
Jan 28 22:56:21 sibermusic volumio[859]: info: -------------------------------------------
Jan 28 22:56:21 sibermusic volumio[859]: info: ----- Volumio3 ----
Jan 28 22:56:21 sibermusic volumio[859]: info: -------------------------------------------
Jan 28 22:56:21 sibermusic volumio[859]: info: ----- System startup ----
Jan 28 22:56:21 sibermusic volumio[859]: info: -------------------------------------------
Jan 28 22:56:21 sibermusic volumio[859]: info: MYVOLUMIO Environment detected
Jan 28 22:56:22 sibermusic volumio[859]: info: Plugin folders cleanup
Jan 28 22:56:22 sibermusic volumio[859]: info: Scanning into folder /volumio/app/plugins/
Jan 28 22:56:22 sibermusic volumio[859]: info: Scanning category audio_interface
Jan 28 22:56:22 sibermusic volumio[859]: info: Scanning category miscellanea
Jan 28 22:56:22 sibermusic volumio[859]: info: Scanning category music_service
Jan 28 22:56:22 sibermusic volumio[859]: info: Scanning category plugins.json
Jan 28 22:56:22 sibermusic volumio[859]: info: Scanning category system_controller
Jan 28 22:56:22 sibermusic volumio[859]: info: Scanning category user_interface
Jan 28 22:56:22 sibermusic volumio[859]: info: Scanning into folder /data/plugins/
Jan 28 22:56:22 sibermusic volumio[859]: info: Scanning category music_service
Jan 28 22:56:22 sibermusic volumio[859]: info: Scanning category system_hardware
Jan 28 22:56:22 sibermusic volumio[859]: info: Scanning category user_interface
Jan 28 22:56:22 sibermusic volumio[859]: info: Plugin folders cleanup completed
Jan 28 22:56:22 sibermusic volumio[859]: info: -------------------------------------------
Jan 28 22:56:22 sibermusic volumio[859]: info: ----- Core plugins startup ----
Jan 28 22:56:22 sibermusic volumio[859]: info: -------------------------------------------
Jan 28 22:56:22 sibermusic volumio[859]: info: Loading plugins from folder /volumio/app/plugins/
Jan 28 22:56:22 sibermusic volumio[859]: info: Adding plugin upnp to MyMusic Plugins
Jan 28 22:56:22 sibermusic volumio[859]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jan 28 22:56:22 sibermusic volumio[859]: info: Adding plugin upnp_browser to MyMusic Plugins
Jan 28 22:56:22 sibermusic volumio[859]: info: Loading plugins from folder /data/plugins/
Jan 28 22:56:22 sibermusic volumio[859]: info: Loading plugin "system"...
Jan 28 22:56:22 sibermusic volumio[859]: info: Loading plugin "appearance"...
Jan 28 22:56:23 sibermusic volumio[859]: info: Loading plugin "network"...
Jan 28 22:56:23 sibermusic volumio[859]: info: Refreshing Cached IP Addresses
Jan 28 22:56:23 sibermusic sudo[896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 28 22:56:23 sibermusic sudo[896]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:23 sibermusic sudo[896]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:23 sibermusic volumio[859]: info: Loading plugin "services"...
Jan 28 22:56:23 sibermusic volumio[859]: info: Loading plugin "alsa_controller"...
Jan 28 22:56:23 sibermusic sudo[901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jan 28 22:56:23 sibermusic sudo[901]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:23 sibermusic sudo[900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 28 22:56:23 sibermusic sudo[900]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:23 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:23] [connect] Successful connection
Jan 28 22:56:23 sibermusic sudo[900]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 28 22:56:23 sibermusic volumio[859]: info: Loading plugin "wizard"...
Jan 28 22:56:23 sibermusic volumio[859]: info: Loading plugin "networkfs"...
Jan 28 22:56:23 sibermusic volumio[859]: info: Starting Udev Watcher for removable devices
Jan 28 22:56:23 sibermusic sudo[910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.10/sibernas /mnt/NAS/sibernas
Jan 28 22:56:23 sibermusic sudo[910]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:23 sibermusic kernel: Key type cifs.spnego registered
Jan 28 22:56:23 sibermusic kernel: Key type cifs.idmap registered
Jan 28 22:56:23 sibermusic kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount.
Jan 28 22:56:23 sibermusic kernel: CIFS: Attempting to mount \\192.168.178.10\sibernas
Jan 28 22:56:23 sibermusic volumio[859]: info: Ignoring mount for partition: boot
Jan 28 22:56:23 sibermusic volumio[859]: info: Ignoring mount for partition: volumio
Jan 28 22:56:23 sibermusic volumio[859]: info: Ignoring mount for partition: volumio_data
Jan 28 22:56:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 28 22:56:23 sibermusic volumio[859]: info: Loading plugin "volumio_command_line_client"...
Jan 28 22:56:23 sibermusic volumio[859]: info: Loading plugin "upnp"...
Jan 28 22:56:23 sibermusic volumio[859]: info: [1706478983703] Starting Upmpd Daemon
Jan 28 22:56:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 28 22:56:23 sibermusic volumio[859]: info: Loading plugin "my_music"...
Jan 28 22:56:23 sibermusic volumio[859]: info: Loading plugin "mpd"...
Jan 28 22:56:24 sibermusic sudo[910]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:24 sibermusic volumio[859]: info: Loading plugin "upnp_browser"...
Jan 28 22:56:24 sibermusic volumio[859]: info: Loading plugin "alarm-clock"...
Jan 28 22:56:24 sibermusic volumio[859]: info: Plugin airplay_emulation is not enabled
Jan 28 22:56:24 sibermusic volumio[859]: info: Loading plugin "last_100"...
Jan 28 22:56:24 sibermusic volumio[859]: info: Loading plugin "webradio"...
Jan 28 22:56:24 sibermusic volumio[859]: info: Loading plugin "i2s_dacs"...
Jan 28 22:56:24 sibermusic volumio[859]: info: I2S DAC not set, start Auto-detection
Jan 28 22:56:24 sibermusic volumio[859]: info: Loading plugin "volumiodiscovery"...
Jan 28 22:56:24 sibermusic volumio[859]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jan 28 22:56:24 sibermusic volumio[859]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 28 22:56:24 sibermusic node[859]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jan 28 22:56:24 sibermusic volumio[859]: *** WARNING *** For more information see
Jan 28 22:56:24 sibermusic volumio[859]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jan 28 22:56:24 sibermusic volumio[859]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 28 22:56:24 sibermusic volumio[859]: *** WARNING *** For more information see
Jan 28 22:56:24 sibermusic node[859]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 28 22:56:24 sibermusic node[859]: *** WARNING *** For more information see
Jan 28 22:56:24 sibermusic node[859]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jan 28 22:56:24 sibermusic node[859]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 28 22:56:24 sibermusic node[859]: *** WARNING *** For more information see
Jan 28 22:56:24 sibermusic volumio[859]: info: Applying required configuration parameters for plugin volumiodiscovery
Jan 28 22:56:24 sibermusic volumio[859]: info: Discovery: Started advertising with name: sibermusic
Jan 28 22:56:24 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 28 22:56:24 sibermusic volumio[859]: info: Loading plugin "bandcamp"...
Jan 28 22:56:26 sibermusic sudo[901]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:28 sibermusic systemd[1]: systemd-fsckd.service: Succeeded.
Jan 28 22:56:28 sibermusic volumio[859]: info: Loading plugin "spop"...
Jan 28 22:56:30 sibermusic volumio[859]: info: Loading plugin "ytmusic"...
Jan 28 22:56:30 sibermusic sh[405]: timed out
Jan 28 22:56:30 sibermusic dhcpcd[455]: timed out
Jan 28 22:56:30 sibermusic sh[405]: dhcpcd exited
Jan 28 22:56:30 sibermusic dhcpcd[455]: dhcpcd exited
Jan 28 22:56:30 sibermusic sh[405]: ifup: failed to bring up eth0
Jan 28 22:56:30 sibermusic systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Jan 28 22:56:30 sibermusic systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Jan 28 22:56:31 sibermusic volumio[859]: info: Loading plugin "now_playing"...
Jan 28 22:56:32 sibermusic volumio[859]: info: Loading plugin "outputs"...
Jan 28 22:56:32 sibermusic volumio[859]: info: Loading plugin "albumart"...
Jan 28 22:56:32 sibermusic volumio[859]: info: Plugin example_plugin is not enabled
Jan 28 22:56:32 sibermusic volumio[859]: info: Loading plugin "inputs"...
Jan 28 22:56:32 sibermusic volumio[859]: info: Loading plugin "updater_comm"...
Jan 28 22:56:32 sibermusic systemd[1]: systemd-hostnamed.service: Succeeded.
Jan 28 22:56:32 sibermusic volumio[859]: info: Plugin mpdemulation is not enabled
Jan 28 22:56:32 sibermusic volumio[859]: info: Loading plugin "rest_api"...
Jan 28 22:56:32 sibermusic volumio[859]: info: Loading plugin "websocket"...
Jan 28 22:56:32 sibermusic volumio[859]: info: Loading plugin "ir_controller"...
Jan 28 22:56:32 sibermusic volumio[859]: Forking 3 albumart workers
Jan 28 22:56:32 sibermusic volumio[859]: info: Applying required configuration parameters for plugin ir_controller
Jan 28 22:56:33 sibermusic volumio[859]: info: Loading plugin "music_services_shield"...
Jan 28 22:56:33 sibermusic volumio[859]: info: Applying required configuration parameters for plugin music_services_shield
Jan 28 22:56:33 sibermusic volumio[859]: info: Loading plugin "touch_display"...
Jan 28 22:56:33 sibermusic volumio[859]: Starting albumart workers
Jan 28 22:56:33 sibermusic volumio[859]: Starting albumart workers
Jan 28 22:56:33 sibermusic volumio[859]: Starting albumart workers
Jan 28 22:56:33 sibermusic volumio[859]: info: Applying required configuration parameters for plugin touch_display
Jan 28 22:56:34 sibermusic volumio[859]: info: Loading i18n strings for locale en
Jan 28 22:56:34 sibermusic volumio[859]: Updating browse sources language
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::initPlayerControls
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 28 22:56:34 sibermusic volumio[859]: Express server listening on port 3000
Jan 28 22:56:34 sibermusic volumio[859]: [Metrics] WebUI: 13s 903.24ms
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreStateMachine::resetVolumioState
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreStateMachine::getcurrentVolume
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::volumioRetrievevolume
Jan 28 22:56:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 22:56:34 sibermusic sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 28 22:56:34 sibermusic sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:34 sibermusic sudo[997]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:34 sibermusic sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 28 22:56:34 sibermusic sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:34 sibermusic sudo[1000]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:35 sibermusic volumio[859]: verbose: New Socket.io Connection to 192.168.178.227:3000 from 192.168.178.73 UA: node-XMLHttpRequest Total Clients: 1
Jan 28 22:56:35 sibermusic volumio[859]: verbose: New Socket.io Connection to 192.168.178.227:3000 from 192.168.178.73 UA: node-XMLHttpRequest Total Clients: 2
Jan 28 22:56:35 sibermusic volumio[859]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3
Jan 28 22:56:35 sibermusic volumio[859]: info: VolumeController:: Volume=73 Mute =false
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreStateMachine::pushState
Jan 28 22:56:35 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioPushState
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreStateMachine::updateTrackBlock
Jan 28 22:56:35 sibermusic volumio[859]: info: CorePlayQueue::getTrackBlock
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioRetrievevolume
Jan 28 22:56:35 sibermusic volumio[859]: info: Reloading queue from file
Jan 28 22:56:35 sibermusic volumio[859]: info: Setting Device type: Raspberry PI
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreStateMachine::setRepeat false single undefined
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreStateMachine::pushState
Jan 28 22:56:35 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioPushState
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreStateMachine::setRandom false
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreStateMachine::pushState
Jan 28 22:56:35 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioPushState
Jan 28 22:56:35 sibermusic sudo[1012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jan 28 22:56:35 sibermusic sudo[1012]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Jan 28 22:56:35 sibermusic volumio[859]: info: VolumeController:: Volume=73 Mute =false
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreStateMachine::pushState
Jan 28 22:56:35 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioPushState
Jan 28 22:56:35 sibermusic volumio[859]: info: Discovery: adding 411a939b-97a5-4cdf-b005-bdba7cc60c5a
Jan 28 22:56:35 sibermusic volumio[859]: info: Discovery: Found device sibermusic
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 28 22:56:35 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 28 22:56:35 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:35 sibermusic systemd[1]: Started UPnP Renderer front-end to MPD.
Jan 28 22:56:35 sibermusic volumio[859]: info: Completed loading Core Plugins
Jan 28 22:56:35 sibermusic volumio[859]: info: Preparing to generate the ALSA configuration file
Jan 28 22:56:35 sibermusic sudo[1012]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:35 sibermusic volumio[859]: info: Upmpdcli Daemon Started
Jan 28 22:56:35 sibermusic volumio[859]: info: Discovery: adding bead4742-cfbb-4ddb-b635-1868495b0e00
Jan 28 22:56:35 sibermusic volumio[859]: info: Discovery: Found device siberup
Jan 28 22:56:35 sibermusic volumio[859]: info: Discovery: Connecting to remote: 192.168.178.73
Jan 28 22:56:35 sibermusic volumio[859]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Jan 28 22:56:35 sibermusic volumio[859]: info: Asound.conf file written
Jan 28 22:56:35 sibermusic sudo[1016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jan 28 22:56:35 sibermusic sudo[1016]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:35 sibermusic sudo[1016]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:35 sibermusic volumio[859]: info: Output device has changed, restarting MPD
Jan 28 22:56:35 sibermusic sudo[1021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 28 22:56:35 sibermusic sudo[1021]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:35 sibermusic volumio[859]: info: ___________ START PLUGINS ___________
Jan 28 22:56:35 sibermusic sudo[1021]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:35 sibermusic volumio[859]: info: ControllerMpd::onStart: Initializing MPD
Jan 28 22:56:35 sibermusic volumio[859]: info: Creating MPD Configuration file
Jan 28 22:56:35 sibermusic sudo[1024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 28 22:56:35 sibermusic sudo[1024]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:35 sibermusic systemd[1]: musicservicesshield.service: Succeeded.
Jan 28 22:56:35 sibermusic systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Jan 28 22:56:35 sibermusic systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 28 22:56:35 sibermusic volumio[859]: info: [1706478995668] CoreMusicLibrary::Adding element Media Servers
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 22:56:35 sibermusic sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 28 22:56:35 sibermusic sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 28 22:56:35 sibermusic volumio[859]: info: [1706478995684] CoreMusicLibrary::Adding element Last_100
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 28 22:56:35 sibermusic volumio[859]: info: [1706478995686] CoreMusicLibrary::Adding element Webradio
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 28 22:56:35 sibermusic volumio[859]: info: [1706478995702] CoreMusicLibrary::Adding element Bandcamp Discover
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 22:56:35 sibermusic volumio[859]: Cannot find translation for source Bandcamp Discover
Jan 28 22:56:35 sibermusic volumio[859]: info: Creating Spotify config file
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:35 sibermusic sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 28 22:56:35 sibermusic sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:35 sibermusic sudo[1028]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:35 sibermusic systemd[1]: Listening on mpd.socket.
Jan 28 22:56:35 sibermusic systemd[1]: Starting Music Player Daemon...
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 28 22:56:35 sibermusic volumio[859]: info: [1706478995764] CoreMusicLibrary::Adding element YouTube Music
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 22:56:35 sibermusic volumio[859]: Cannot find translation for source Bandcamp Discover
Jan 28 22:56:35 sibermusic volumio[859]: Cannot find translation for source YouTube Music
Jan 28 22:56:35 sibermusic systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jan 28 22:56:35 sibermusic systemd[1]: mpd.service: Succeeded.
Jan 28 22:56:35 sibermusic systemd[1]: Stopped Music Player Daemon.
Jan 28 22:56:35 sibermusic systemd[1]: Starting Music Player Daemon...
Jan 28 22:56:35 sibermusic volumio[859]: info: [now-playing] ConfigUpdater: config is up to date.
Jan 28 22:56:35 sibermusic volumio[859]: info: Loading i18n strings for locale en
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 28 22:56:35 sibermusic sudo[1034]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 28 22:56:35 sibermusic sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:35 sibermusic sudo[1034]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Jan 28 22:56:35 sibermusic sudo[1034]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:35 sibermusic volumio[859]: info: Loading i18n strings for locale en
Jan 28 22:56:35 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 28 22:56:35 sibermusic volumio[859]: info: Volumio Calling Home
Jan 28 22:56:36 sibermusic sudo[1063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Jan 28 22:56:36 sibermusic sudo[1063]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:36 sibermusic sudo[1081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Jan 28 22:56:36 sibermusic sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:36 sibermusic systemd[1]: Reloading.
Jan 28 22:56:36 sibermusic sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc
Jan 28 22:56:36 sibermusic sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:36 sibermusic sudo[1080]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:36 sibermusic volumio[859]: info: [now-playing] Fetching API key...
Jan 28 22:56:36 sibermusic volumio[859]: info: [now-playing] App is listening on port 4004.
Jan 28 22:56:36 sibermusic volumio[859]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds
Jan 28 22:56:36 sibermusic volumio[859]: info: ir_controller: File permissions successfully set on /etc/lirc/*.
Jan 28 22:56:36 sibermusic volumio[859]: info: MPD Permissions set
Jan 28 22:56:36 sibermusic volumio[859]: info: MPD Permissions set
Jan 28 22:56:36 sibermusic volumio[859]: info: Volumio called home
Jan 28 22:56:36 sibermusic volumio[859]: info: Spotify config file written
Jan 28 22:56:36 sibermusic volumio[859]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic sudo[1101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Jan 28 22:56:36 sibermusic sudo[1101]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 22:56:36 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:36 sibermusic systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Jan 28 22:56:36 sibermusic volumio[859]: info: Discovery: Connected to remote: 192.168.178.73
Jan 28 22:56:36 sibermusic volumio[859]: info: touch_display: Raspberry Pi Foundation touch screen detected.
Jan 28 22:56:36 sibermusic volumio[859]: info: touch_display: Backlight module of a Raspberry Pi Foundation touch screen detected.
Jan 28 22:56:36 sibermusic sudo[1063]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:36 sibermusic systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Jan 28 22:56:36 sibermusic sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh
Jan 28 22:56:36 sibermusic sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:37 sibermusic sudo[1081]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:37 sibermusic volumio[859]: info: ir_controller: LIRC correctly updated.
Jan 28 22:56:37 sibermusic volumio[859]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver!
Jan 28 22:56:37 sibermusic volumio[859]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------
Jan 28 22:56:37 sibermusic volumio[859]: SPOTIFY: BQDvN8N1i7ok9mm5FQ92SYvTUX4XritWeXMIwMxEtAJ2v1HtaVrgNqjc8z9NuMQd809Wr4B6fxm6XsKqoqQ4R2Pwp_tLCT3FCrv6yZq-7V0_4B232BHcrrep3n8WlYYG3FF7wYMaoLdaONtUZM9hRgsX1RH6dvGSctrXZ3gRMIoUOtqx5tiIJpF6r6udfIIkUb02Xq4G1-7dMB8xSjBocUwnXQqC1qzMVeT7-ze-K5VcnR9ieKDAFGGlABLlxkTVpHtGAmXjgOU
Jan 28 22:56:37 sibermusic volumio[859]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------
Jan 28 22:56:37 sibermusic volumio[859]: info: New Spotify access token = BQDvN8N1i7ok9mm5FQ92SYvTUX4XritWeXMIwMxEtAJ2v1HtaVrgNqjc8z9NuMQd809Wr4B6fxm6XsKqoqQ4R2Pwp_tLCT3FCrv6yZq-7V0_4B232BHcrrep3n8WlYYG3FF7wYMaoLdaONtUZM9hRgsX1RH6dvGSctrXZ3gRMIoUOtqx5tiIJpF6r6udfIIkUb02Xq4G1-7dMB8xSjBocUwnXQqC1qzMVeT7-ze-K5VcnR9ieKDAFGGlABLlxkTVpHtGAmXjgOU
Jan 28 22:56:37 sibermusic volumio[859]: info: Spotify credentials grant success - running version from March 24, 2019
Jan 28 22:56:37 sibermusic go-librespot[1127]: Librespot-go daemon starting...
Jan 28 22:56:37 sibermusic systemd[1]: Started go-librespot Daemon.
Jan 28 22:56:37 sibermusic volumio[859]: info: touch_display: systemctl daemon-reload succeeded.
Jan 28 22:56:37 sibermusic sudo[1101]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:37 sibermusic sudo[1133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/devices/platform/rpi_backlight/backlight/rpi_backlight/brightness
Jan 28 22:56:37 sibermusic volumio[859]: info: ir_controller: Raspberry Pi revision code: c03112
Jan 28 22:56:37 sibermusic sudo[1133]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:37 sibermusic sudo[1133]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:37 sibermusic sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Jan 28 22:56:37 sibermusic sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:37 sibermusic systemd[1]: Started Volumio Kiosk.
Jan 28 22:56:37 sibermusic sudo[1132]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:37 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 28 22:56:37 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:37 sibermusic volumio[859]: info: touch_display: File permissions for backlight brightness control set.
Jan 28 22:56:37 sibermusic volumio[859]: info: touch_display: systemctl start volumio-kiosk.service succeeded.
Jan 28 22:56:37 sibermusic volumio[859]: info: touch_display: Volumio Kiosk started
Jan 28 22:56:37 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 28 22:56:37 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:37 sibermusic mpd[1044]: Jan 28 22:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jan 28 22:56:37 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 28 22:56:37 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:37 sibermusic volumio[859]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Jan 28 22:56:37 sibermusic volumio[859]: SPOTIFY: User informations: {"display_name":"sibermusic","external_urls":{"spotify":"https://open.spotify.com/user/31oqpqhlnukeslyt3pinp75emawe"},"href":"https://api.spotify.com/v1/users/31oqpqhlnukeslyt3pinp75emawe","id":"31oqpqhlnukeslyt3pinp75emawe","images":[{"url":"https://i.scdn.co/image/ab67757000003b8268686fe646192cee39d908f9","height":64,"width":64},{"url":"https://i.scdn.co/image/ab6775700000ee8568686fe646192cee39d908f9","height":300,"width":300}],"type":"user","uri":"spotify:user:31oqpqhlnukeslyt3pinp75emawe","followers":{"href":null,"total":0},"country":"NL","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"gee.siber@gmail.com"}
Jan 28 22:56:37 sibermusic volumio[859]: info: Spotify Successfully logged in
Jan 28 22:56:37 sibermusic sudo[1168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r -1
Jan 28 22:56:37 sibermusic volumio[859]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 28 22:56:37 sibermusic volumio[859]: info: [1706478997993] CoreMusicLibrary::Adding element Spotify
Jan 28 22:56:37 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 22:56:37 sibermusic volumio[859]: Cannot find translation for source Bandcamp Discover
Jan 28 22:56:37 sibermusic volumio[859]: Cannot find translation for source YouTube Music
Jan 28 22:56:37 sibermusic volumio[859]: Cannot find translation for source Spotify
Jan 28 22:56:37 sibermusic sudo[1168]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:38 sibermusic sudo[1168]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:38 sibermusic systemd[1]: Started Music Player Daemon.
Jan 28 22:56:38 sibermusic systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Jan 28 22:56:38 sibermusic sudo[1024]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:38 sibermusic sudo[1029]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:38 sibermusic volumio[859]: info: Completed starting Core Plugins
Jan 28 22:56:38 sibermusic volumio[859]: info: -------------------------------------------
Jan 28 22:56:38 sibermusic volumio[859]: info: ----- MyVolumio plugins startup ----
Jan 28 22:56:38 sibermusic volumio[859]: info: -------------------------------------------
Jan 28 22:56:38 sibermusic volumio[859]: info: [MyVolumio PluginManager] Fetching plans data....
Jan 28 22:56:38 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:38] [connect] Successful connection
Jan 28 22:56:38 sibermusic startx[1138]: X.Org X Server 1.20.4
Jan 28 22:56:38 sibermusic startx[1138]: X Protocol Version 11, Revision 0
Jan 28 22:56:38 sibermusic startx[1138]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian
Jan 28 22:56:38 sibermusic startx[1138]: Current Operating System: Linux sibermusic 6.1.70-v7l+ #1712 SMP Tue Jan 2 18:29:06 GMT 2024 armv7l
Jan 28 22:56:38 sibermusic startx[1138]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:6C:7A:FC vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0
Jan 28 22:56:38 sibermusic startx[1138]: Build Date: 04 April 2023 07:50:56AM
Jan 28 22:56:38 sibermusic startx[1138]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support)
Jan 28 22:56:38 sibermusic startx[1138]: Current version of pixman: 0.36.0
Jan 28 22:56:38 sibermusic startx[1138]: Before reporting problems, check http://wiki.x.org
Jan 28 22:56:38 sibermusic startx[1138]: to make sure that you have the latest version.
Jan 28 22:56:38 sibermusic startx[1138]: Markers: (--) probed, (**) from config file, (==) default setting,
Jan 28 22:56:38 sibermusic startx[1138]: (++) from command line, (!!) notice, (II) informational,
Jan 28 22:56:38 sibermusic startx[1138]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Jan 28 22:56:38 sibermusic startx[1138]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Jan 28 22:56:38 2024
Jan 28 22:56:38 sibermusic sudo[1187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=25 gpio_pull=up
Jan 28 22:56:38 sibermusic startx[1138]: (==) Using config directory: "/etc/X11/xorg.conf.d"
Jan 28 22:56:38 sibermusic startx[1138]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Jan 28 22:56:38 sibermusic sudo[1187]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:38 sibermusic volumio[859]: info: MPD running with PID1044
Jan 28 22:56:38 sibermusic volumio[859]: ,establishing connection
Jan 28 22:56:38 sibermusic volumio[859]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Jan 28 22:56:38 sibermusic go-librespot[1127]: time="2024-01-28T22:56:38+01:00" level=info msg="generated new device id: 02f67be98da341fc9fdcf52d7e6302f9ecd5e18e"
Jan 28 22:56:38 sibermusic go-librespot[1127]: time="2024-01-28T22:56:38+01:00" level=debug msg="stored credentials found for 31oqpqhlnukeslyt3pinp75emawe"
Jan 28 22:56:38 sibermusic kernel: Registered IR keymap rc-rc6-mce
Jan 28 22:56:38 sibermusic kernel: IR RC6 protocol handler initialized
Jan 28 22:56:38 sibermusic volumio[859]: error: MPD error: The expression evaluated to a falsy value:
Jan 28 22:56:38 sibermusic volumio[859]: assert.ok(self.idling)
Jan 28 22:56:38 sibermusic volumio[859]: error: The expression evaluated to a falsy value:
Jan 28 22:56:38 sibermusic volumio[859]: assert.ok(self.idling)
Jan 28 22:56:38 sibermusic volumio[859]: error: MPD error: The expression evaluated to a falsy value:
Jan 28 22:56:38 sibermusic volumio[859]: assert.ok(self.idling)
Jan 28 22:56:38 sibermusic volumio[859]: error: The expression evaluated to a falsy value:
Jan 28 22:56:38 sibermusic volumio[859]: assert.ok(self.idling)
Jan 28 22:56:38 sibermusic volumio-remote-updater[530]: [2024-01-28 22:56:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1706478998 101
Jan 28 22:56:38 sibermusic sudo[1187]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:38 sibermusic kernel: rc rc0: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0
Jan 28 22:56:38 sibermusic kernel: rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter
Jan 28 22:56:38 sibermusic kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0/input1
Jan 28 22:56:38 sibermusic volumio[859]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 5
Jan 28 22:56:38 sibermusic kernel: rc rc0: two consecutive events of type space
Jan 28 22:56:38 sibermusic volumio[859]: info: ir_controller: Overlay gpio-ir gpio_pin=25 gpio_pull=up loaded.
Jan 28 22:56:38 sibermusic sudo[1220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service
Jan 28 22:56:38 sibermusic sudo[1220]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:38 sibermusic systemd[1]: Starting lircd(8) initialization helper tool...
Jan 28 22:56:38 sibermusic volumio[859]: error: updateQueue error: null
Jan 28 22:56:38 sibermusic volumio[859]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Jan 28 22:56:38 sibermusic sudo[1227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service
Jan 28 22:56:38 sibermusic sudo[1227]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:38 sibermusic systemd-udevd[1202]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jan 28 22:56:38 sibermusic systemd-logind[507]: Watching system buttons on /dev/input/event1 (gpio_ir_recv)
Jan 28 22:56:38 sibermusic volumio[1178]: cset: --> shielding system active with
Jan 28 22:56:38 sibermusic volumio[1178]: cset: "system" cpuset of CPUSPEC(2-3) with 119 tasks running
Jan 28 22:56:38 sibermusic volumio[1178]: cset: "user" cpuset of CPUSPEC(0-1) with 3 tasks running
Jan 28 22:56:38 sibermusic go-librespot[1127]: time="2024-01-28T22:56:38+01:00" level=debug msg="obtained new client token: AADlQoDowmZXm+ld9P5NDu+Y+lZK4g6ver6/Agh0d8+nGHj4GrogNUER3DOEwLFkyu1lnxi0JxrIQmcmPz3PTmK2Xa/RIcdorctm+BrskxCP3K8NLuU06b0qZdRG5bT0dBERlMAqzugU5JM9JmwoCTMOJx4YbdIuXx4UpTnatozgSnhHYboEoKK3CkeONq/YDsHOhZ18VMUGubBEVrTrM8BXmpjiydptVZa3+BbSROoOoAReH+ywmZu2SURHPEk="
Jan 28 22:56:38 sibermusic systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Jan 28 22:56:38 sibermusic systemd[1]: Reloading.
Jan 28 22:56:39 sibermusic go-librespot[1127]: time="2024-01-28T22:56:39+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Jan 28 22:56:39 sibermusic go-librespot[1127]: time="2024-01-28T22:56:39+01:00" level=debug msg="completed keyexchange"
Jan 28 22:56:39 sibermusic volumio[859]: info: [now-playing] OpenWeatherMap API key obtained.
Jan 28 22:56:39 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 22:56:39 sibermusic volumio[859]: info: Discovery: Getting this device information
Jan 28 22:56:39 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 28 22:56:39 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:39 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 22:56:39 sibermusic go-librespot[1127]: time="2024-01-28T22:56:39+01:00" level=debug msg="completed challenge"
Jan 28 22:56:39 sibermusic lircd-setup[1226]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead.
Jan 28 22:56:39 sibermusic lircd-setup[1226]: parser = configparser.SafeConfigParser()
Jan 28 22:56:39 sibermusic go-librespot[1127]: time="2024-01-28T22:56:39+01:00" level=debug msg="authenticated as 31oqpqhlnukeslyt3pinp75emawe"
Jan 28 22:56:39 sibermusic systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Jan 28 22:56:39 sibermusic volumio[1014]: Generating RSA private key, 4096 bit long modulus (2 primes)
Jan 28 22:56:39 sibermusic go-librespot[1127]: time="2024-01-28T22:56:39+01:00" level=debug msg="authenticated as 31oqpqhlnukeslyt3pinp75emawe"
Jan 28 22:56:39 sibermusic go-librespot[1127]: time="2024-01-28T22:56:39+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Jan 28 22:56:39 sibermusic go-librespot[1127]: time="2024-01-28T22:56:39+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Jan 28 22:56:40 sibermusic go-librespot[1127]: time="2024-01-28T22:56:40+01:00" level=debug msg="dealer connection opened"
Jan 28 22:56:40 sibermusic go-librespot[1127]: time="2024-01-28T22:56:40+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336"
Jan 28 22:56:40 sibermusic go-librespot[1127]: time="2024-01-28T22:56:40+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2"
Jan 28 22:56:40 sibermusic go-librespot[1127]: time="2024-01-28T22:56:40+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17"
Jan 28 22:56:40 sibermusic go-librespot[1127]: time="2024-01-28T22:56:40+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0"
Jan 28 22:56:40 sibermusic go-librespot[1127]: time="2024-01-28T22:56:40+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513"
Jan 28 22:56:40 sibermusic go-librespot[1127]: time="2024-01-28T22:56:40+01:00" level=debug msg="received connection id: ZTU4MzE0MzctZTU2Yy00OTliLWJkNWItY2Q1NzYwOWU1MjkwK2RlYWxlcit0Y3A6Ly9nZXc0LWRlYWxlci1hLTBzN3QuZ2V3NC5zcG90aWZ5Lm5ldDo1NzAwK0I3NTM1RkQ4MjRCNDRFMEY2NUJFMTc2Q0U2NkZDNUQ0MTY2MUNCOTQwQjk1NUJCQTZDRENEMTFFNDRFRjBBQjg="
Jan 28 22:56:40 sibermusic go-librespot[1127]: time="2024-01-28T22:56:40+01:00" level=debug msg="put connect state because NEW_DEVICE"
Jan 28 22:56:40 sibermusic sudo[1122]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:40 sibermusic systemd[1]: lircd-setup.service: Succeeded.
Jan 28 22:56:40 sibermusic volumio[859]: info: succeeded
Jan 28 22:56:40 sibermusic systemd[1]: Started lircd(8) initialization helper tool.
Jan 28 22:56:40 sibermusic volumio[859]: info: go-librespot daemon successfully initialized
Jan 28 22:56:40 sibermusic systemd[1]: Starting Flexible IR remote input/output application support...
Jan 28 22:56:40 sibermusic volumio[859]: info: touch_display: Setting screensaver timeout to 0 seconds.
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Info: lircd: Opening log, level: Info
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Version: lircd 0.10.1
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: System info: Linux sibermusic 6.1.70-v7l+ #1712 SMP Tue Jan 2 18:29:06 GMT 2024 armv7l GNU/Linux
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Info: Initial device: /dev/lirc0
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: 'lirc' written to protocols file /sys/class/rc/rc0/protocols
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Info: Initial device: /dev/lirc0
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Info: [lirc] protocol is enabled
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: driver: default
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: output: /var/run/lirc/lircd
Jan 28 22:56:40 sibermusic lircd[1341]: lircd-0.10.1[1341]: Info: lircd: Opening log, level: Info
Jan 28 22:56:40 sibermusic lircd[1341]: lircd-0.10.1[1341]: Notice: Using systemd fd
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: nodaemon: 1
Jan 28 22:56:40 sibermusic lircd[1341]: lircd-0.10.1[1341]: Warning: Running as root
Jan 28 22:56:40 sibermusic lircd[1341]: lircd-0.10.1[1341]: Info: Using remote: odroid.
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins
Jan 28 22:56:40 sibermusic lircd[1341]: lircd-0.10.1[1341]: Notice: lircd(default) ready, using /var/run/lirc/lircd
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: logfile: syslog
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: immediate-init: 0
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: permission: 666
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: driver-options:
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: pidfile: /var/run/lirc/lircd.pid
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: listen: 0
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: connect: (null)
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: userelease: 0
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: effective_user: (null)
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: release_suffix: _EVUP
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: allow_simulate: 0
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: repeat_max: 600
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: configfile: /etc/lirc/lircd.conf
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Options: dynamic_codes: (null)
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Current driver: default
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Driver API version: 3
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Driver version: 0.10.0
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Info: lircd: Opening log, level: Info
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: Using systemd fd
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Warning: Running as root
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Info: Using remote: odroid.
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: lircd(default) ready, using /var/run/lirc/lircd
Jan 28 22:56:40 sibermusic systemd[1]: Started Flexible IR remote input/output application support.
Jan 28 22:56:40 sibermusic sudo[1227]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:40 sibermusic sudo[1220]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:40 sibermusic volumio[859]: info: ir_controller: systemctl restart lircd.service succeeded.
Jan 28 22:56:40 sibermusic volumio[859]: info: ir_controller: systemctl restart lircd.service succeeded.
Jan 28 22:56:40 sibermusic sudo[1366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service
Jan 28 22:56:40 sibermusic sudo[1366]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:40 sibermusic sudo[1373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service
Jan 28 22:56:40 sibermusic sudo[1373]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 22:56:40 sibermusic systemd[1]: Started Handle events from IR remotes decoded by lircd(8).
Jan 28 22:56:40 sibermusic sudo[1366]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:40 sibermusic volumio[859]: info: ir_controller: systemctl restart irexec.service succeeded.
Jan 28 22:56:40 sibermusic lircd[1341]: lircd-0.10.1[1341]: Notice: accepted new client on /var/run/lirc/lircd
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Notice: accepted new client on /var/run/lirc/lircd
Jan 28 22:56:40 sibermusic lircd[1341]: lircd-0.10.1[1341]: Info: [lirc] protocol is enabled
Jan 28 22:56:40 sibermusic lircd-0.10.1[1341]: Info: [lirc] protocol is enabled
Jan 28 22:56:41 sibermusic lircd-0.10.1[1341]: Info: removed client
Jan 28 22:56:41 sibermusic lircd[1341]: lircd-0.10.1[1341]: Info: removed client
Jan 28 22:56:41 sibermusic systemd[1]: Stopping Handle events from IR remotes decoded by lircd(8)...
Jan 28 22:56:41 sibermusic systemd[1]: irexec.service: Main process exited, code=killed, status=15/TERM
Jan 28 22:56:41 sibermusic systemd[1]: irexec.service: Succeeded.
Jan 28 22:56:41 sibermusic systemd[1]: Stopped Handle events from IR remotes decoded by lircd(8).
Jan 28 22:56:41 sibermusic systemd[1]: Started Handle events from IR remotes decoded by lircd(8).
Jan 28 22:56:41 sibermusic sudo[1373]: pam_unix(sudo:session): session closed for user root
Jan 28 22:56:41 sibermusic volumio[859]: info: ir_controller: systemctl restart irexec.service succeeded.
Jan 28 22:56:41 sibermusic lircd-0.10.1[1341]: Notice: accepted new client on /var/run/lirc/lircd
Jan 28 22:56:41 sibermusic lircd[1341]: lircd-0.10.1[1341]: Notice: accepted new client on /var/run/lirc/lircd
Jan 28 22:56:41 sibermusic lircd[1341]: lircd-0.10.1[1341]: Info: [lirc] protocol is enabled
Jan 28 22:56:41 sibermusic lircd-0.10.1[1341]: Info: [lirc] protocol is enabled
Jan 28 22:56:41 sibermusic volumio[1014]: ..............++++
Jan 28 22:56:43 sibermusic volumio[859]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Jan 28 22:56:43 sibermusic volumio[859]: info: Initializing connection to go-librespot Websocket
Jan 28 22:56:43 sibermusic go-librespot[1127]: time="2024-01-28T22:56:43+01:00" level=debug msg="new websocket client"
Jan 28 22:56:43 sibermusic volumio[859]: info: Connection to go-librespot Websocket established
Jan 28 22:56:46 sibermusic volumio[859]: info: Getting Spotify volume
Jan 28 22:56:46 sibermusic volumio[859]: info: Spotify volume: 100
Jan 28 22:56:46 sibermusic volumio[859]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6
Jan 28 22:56:46 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 28 22:56:46 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:46 sibermusic volumio[859]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73
Jan 28 22:56:46 sibermusic volumio[859]: SPOTIFY: SPOTIFY VOLUME 100
Jan 28 22:56:46 sibermusic volumio[859]: SPOTIFY: VOLUMIO VOLUME 73
Jan 28 22:56:46 sibermusic volumio[859]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 22:56:46 sibermusic volumio[859]: info: Setting Spotify Volume from Volumio: 73
Jan 28 22:56:48 sibermusic volumio[859]: SPOTIFY: SETTING SPOTIFY VOLUME 73
Jan 28 22:56:48 sibermusic volumio[859]: info: Sending Spotify command with payload to local API: /player/volume
Jan 28 22:56:48 sibermusic go-librespot[1127]: time="2024-01-28T22:56:48+01:00" level=debug msg="update volume to 47840/65535"
Jan 28 22:56:48 sibermusic go-librespot[1127]: time="2024-01-28T22:56:48+01:00" level=debug msg="put connect state because VOLUME_CHANGED"
Jan 28 22:56:48 sibermusic go-librespot[1127]: time="2024-01-28T22:56:48+01:00" level=trace msg="emitting websocket event: volume"
Jan 28 22:56:48 sibermusic volumio[859]: SPOTIFY: received: {"type":"volume","data":{"value":73,"max":100}}
Jan 28 22:56:48 sibermusic volumio[859]: SPOTIFY: RECEIVED SPOTIFY VOLUME 73
Jan 28 22:56:50 sibermusic volumio[859]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 7
Jan 28 22:56:51 sibermusic volumio[859]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined
Jan 28 22:56:51 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo
Jan 28 22:56:51 sibermusic volumio[859]: info: Listing playlists
Jan 28 22:56:51 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetQueue
Jan 28 22:56:51 sibermusic volumio[859]: info: CoreStateMachine::getQueue
Jan 28 22:56:51 sibermusic volumio[859]: info: CorePlayQueue::getQueue
Jan 28 22:56:51 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 28 22:56:51 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 22:56:51 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 28 22:56:51 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:52 sibermusic volumio[1014]: ............................................................................................................++++
Jan 28 22:56:52 sibermusic volumio[1014]: e is 65537 (0x010001)
Jan 28 22:56:52 sibermusic volumio[1014]: writing RSA key
Jan 28 22:56:58 sibermusic volumio[859]: error: MyVolumio Plugin failed to start in a timely fashion
Jan 28 22:56:58 sibermusic volumio[859]: info: BOOT COMPLETED
Jan 28 22:56:58 sibermusic volumio[859]: [Metrics] CommandRouter: 37s 27.25ms
Jan 28 22:56:58 sibermusic volumio[859]: info: CoreCommandRouter::volumiosetStartupVolume
Jan 28 22:56:58 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 22:56:58 sibermusic volumio[859]: info: VolumeController:: Setting startup Volume 75
Jan 28 22:56:58 sibermusic volumio[859]: info: VolumeController::SetAlsaVolume75
Jan 28 22:56:58 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 22:56:58 sibermusic volumio[859]: info: CoreCommandRouter::Close All Modals sent
Jan 28 22:56:58 sibermusic volumio[859]: info: CoreCommandRouter::Close All Modals sent
Jan 28 22:56:58 sibermusic volumio[859]: info: CoreStateMachine::pushState
Jan 28 22:56:58 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 28 22:56:58 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 22:56:58 sibermusic volumio[859]: info: CoreCommandRouter::volumioPushState
Jan 28 22:56:58 sibermusic volumio[859]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Jan 28 22:56:58 sibermusic volumio[859]: SPOTIFY: SPOTIFY VOLUME 73
Jan 28 22:56:58 sibermusic volumio[859]: SPOTIFY: VOLUMIO VOLUME 75
Jan 28 22:56:58 sibermusic volumio[859]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 22:56:58 sibermusic volumio[859]: info: Setting Spotify Volume from Volumio: 75
Jan 28 22:56:59 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jan 28 22:56:59 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 28 22:56:59 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jan 28 22:56:59 sibermusic volumio[859]: SPOTIFY: SETTING SPOTIFY VOLUME 75
Jan 28 22:56:59 sibermusic volumio[859]: info: Sending Spotify command with payload to local API: /player/volume
Jan 28 22:56:59 sibermusic go-librespot[1127]: time="2024-01-28T22:56:59+01:00" level=debug msg="update volume to 49151/65535"
Jan 28 22:56:59 sibermusic go-librespot[1127]: time="2024-01-28T22:56:59+01:00" level=debug msg="put connect state because VOLUME_CHANGED"
Jan 28 22:56:59 sibermusic go-librespot[1127]: time="2024-01-28T22:56:59+01:00" level=trace msg="emitting websocket event: volume"
Jan 28 22:56:59 sibermusic volumio[859]: SPOTIFY: received: {"type":"volume","data":{"value":75,"max":100}}
Jan 28 22:56:59 sibermusic volumio[859]: SPOTIFY: RECEIVED SPOTIFY VOLUME 75
Jan 28 22:57:05 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 28 22:57:05 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 22:57:05 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 22:57:07 sibermusic ntpd[654]: Soliciting pool server 162.159.200.1
Jan 28 22:57:08 sibermusic ntpd[654]: Soliciting pool server 174.138.107.7
Jan 28 22:57:08 sibermusic ntpd[654]: Soliciting pool server 213.136.0.252
Jan 28 22:57:09 sibermusic ntpd[654]: Soliciting pool server 95.85.21.89
Jan 28 22:57:09 sibermusic ntpd[654]: Soliciting pool server 185.51.192.63
Jan 28 22:57:09 sibermusic ntpd[654]: Soliciting pool server 86.80.166.233
Jan 28 22:57:10 sibermusic ntpd[654]: Soliciting pool server 45.159.204.28
Jan 28 22:57:10 sibermusic ntpd[654]: Soliciting pool server 45.138.55.62
Jan 28 22:57:10 sibermusic ntpd[654]: Soliciting pool server 45.32.4.67
Jan 28 22:57:10 sibermusic ntpd[654]: Soliciting pool server 185.224.145.68
Jan 28 22:57:11 sibermusic ntpd[654]: Soliciting pool server 77.173.137.253
Jan 28 22:57:11 sibermusic ntpd[654]: Soliciting pool server 45.138.55.60
Jan 28 22:57:11 sibermusic ntpd[654]: Soliciting pool server 83.98.201.134
Jan 28 22:57:12 sibermusic ntpd[654]: Soliciting pool server 45.159.204.28
Jan 28 22:57:12 sibermusic ntpd[654]: Soliciting pool server 87.251.32.228
Jan 28 22:57:13 sibermusic ntpd[654]: Soliciting pool server 108.61.189.74
Jan 28 22:57:13 sibermusic ntpd[654]: Soliciting pool server 81.172.225.142
Jan 28 22:57:14 sibermusic ntpd[654]: Soliciting pool server 185.51.192.61
Jan 28 22:57:15 sibermusic ntpd[654]: Soliciting pool server 83.84.240.223
Jan 30 18:28:10 sibermusic ntpd[654]: receive: Unexpected origin timestamp 0xe9614c3c.d87173f0 does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xe963b02a.b6bff3d0
Jan 30 18:28:10 sibermusic ntpd[654]: receive: Unexpected origin timestamp 0xe9614c3c.d86f1523 does not match aorg 0000000000.00000000 from server@86.80.166.233 xmt 0xe963b02a.b78a3f00
Jan 30 18:28:10 sibermusic ntpd[654]: receive: Unexpected origin timestamp 0xe9614c3c.d86c8f89 does not match aorg 0000000000.00000000 from server@77.173.137.253 xmt 0xe963b02a.b6e41f6d
Jan 30 18:28:10 sibermusic ntpd[654]: receive: Unexpected origin timestamp 0xe9614c3c.d870b4ff does not match aorg 0000000000.00000000 from server@174.138.107.7 xmt 0xe963b02a.b98a565e
Jan 30 18:28:10 sibermusic systemd[1]: Starting Daily apt download activities...
Jan 30 18:28:10 sibermusic systemd[1]: Starting Daily man-db regeneration...
Jan 30 18:28:10 sibermusic ntpd[654]: receive: Unexpected origin timestamp 0xe9614c3c.d86d8ad7 does not match aorg 0000000000.00000000 from server@45.32.4.67 xmt 0xe963b02a.bea06d5d
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Jan 30 18:28:12 sibermusic volumio[859]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Jan 30 18:28:13 sibermusic volumio[859]: info: Adding plugin bluetooth to MyMusic Plugins
Jan 30 18:28:13 sibermusic volumio[859]: info: Adding plugin multiroom to MyMusic Plugins
Jan 30 18:28:13 sibermusic volumio[859]: info: Adding plugin metavolumio to MyMusic Plugins
Jan 30 18:28:13 sibermusic volumio[859]: info: Adding plugin cd_controller to MyMusic Plugins
Jan 30 18:28:13 sibermusic volumio[859]: info: Adding plugin smart_inputs to MyMusic Plugins
Jan 30 18:28:13 sibermusic volumio[859]: info: Adding plugin tidalconnect to MyMusic Plugins
Jan 30 18:28:13 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Jan 30 18:28:14 sibermusic volumio[859]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Jan 30 18:28:14 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Jan 30 18:28:14 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:14 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:14 sibermusic volumio[859]: info: Starting MyVolumio Remote Streaming Endpoints
Jan 30 18:28:14 sibermusic volumio[859]: info: MyVolumio login type: Token
Jan 30 18:28:14 sibermusic volumio[859]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Jan 30 18:28:14 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Jan 30 18:28:16 sibermusic nmbd[626]: [2024/01/30 18:28:16.064291, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jan 30 18:28:16 sibermusic nmbd[626]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.227 for name WORKGROUP<1d>.
Jan 30 18:28:16 sibermusic nmbd[626]: This response was from IP 192.168.178.80, reporting an IP address of 192.168.178.80.
Jan 30 18:28:16 sibermusic systemd[1]: man-db.service: Succeeded.
Jan 30 18:28:16 sibermusic systemd[1]: Started Daily man-db regeneration.
Jan 30 18:28:16 sibermusic systemd[1]: apt-daily.service: Succeeded.
Jan 30 18:28:16 sibermusic systemd[1]: Started Daily apt download activities.
Jan 30 18:28:16 sibermusic systemd[1]: Starting Daily apt upgrade and clean activities...
Jan 30 18:28:17 sibermusic volumio[859]: info: Starting Streaming Service Transparent Proxy
Jan 30 18:28:17 sibermusic volumio[859]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Jan 30 18:28:17 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Jan 30 18:28:17 sibermusic volumio[859]: info: Streaming services startup
Jan 30 18:28:17 sibermusic volumio[859]: info: Starting Streaming Daemon
Jan 30 18:28:17 sibermusic sudo[1884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jan 30 18:28:17 sibermusic sudo[1884]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:17 sibermusic volumio[859]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Jan 30 18:28:17 sibermusic sudo[1884]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:17 sibermusic volumio[859]: error: Cannot start Volumio Streaming Daemon
Jan 30 18:28:17 sibermusic volumio[859]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jan 30 18:28:17 sibermusic volumio[859]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jan 30 18:28:17 sibermusic volumio[859]: info: Discovery: A device disappeared from network
Jan 30 18:28:17 sibermusic volumio[859]: info: Discovery: Device siberup disappeared from network
Jan 30 18:28:17 sibermusic volumio[859]: info: Discovery: Disconnected from remote: 192.168.178.73
Jan 30 18:28:17 sibermusic volumio[859]: info: Discovery: A device disappeared from network
Jan 30 18:28:17 sibermusic volumio[859]: info: Discovery: Device sibermusic disappeared from network
Jan 30 18:28:17 sibermusic volumio[859]: info: Discovery: adding 411a939b-97a5-4cdf-b005-bdba7cc60c5a
Jan 30 18:28:17 sibermusic volumio[859]: info: Discovery: Found device sibermusic
Jan 30 18:28:17 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:28:17 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:28:17 sibermusic volumio[859]: info: Discovery: adding bead4742-cfbb-4ddb-b635-1868495b0e00
Jan 30 18:28:17 sibermusic volumio[859]: info: Discovery: Found device siberup
Jan 30 18:28:17 sibermusic volumio[859]: info: Discovery: Connecting to remote: 192.168.178.73
Jan 30 18:28:17 sibermusic volumio[859]: info: Discovery: Connected to remote: 192.168.178.73
Jan 30 18:28:17 sibermusic volumio[859]: error: MyVolumio Custom Token format not valid, refreshing it
Jan 30 18:28:17 sibermusic systemd[1]: apt-daily-upgrade.service: Succeeded.
Jan 30 18:28:17 sibermusic systemd[1]: Started Daily apt upgrade and clean activities.
Jan 30 18:28:18 sibermusic volumio[859]: info: MyVolumio login type: Token
Jan 30 18:28:18 sibermusic volumio[859]: STREAMING PROXY: Starting server on port 3245
Jan 30 18:28:18 sibermusic volumio[859]: Node JS runtime: 14
Jan 30 18:28:18 sibermusic volumio[859]: verbose: New Socket.io Connection to 192.168.178.227 from 192.168.178.66 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Mobile Safari/537.36 Total Clients: 8
Jan 30 18:28:18 sibermusic volumio[859]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:28:20 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetQueue
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreStateMachine::getQueue
Jan 30 18:28:20 sibermusic volumio[859]: info: CorePlayQueue::getQueue
Jan 30 18:28:20 sibermusic volumio[859]: info: Listing playlists
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 30 18:28:20 sibermusic volumio[859]: info: Received Get System Info
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 30 18:28:20 sibermusic volumio[859]: info: Discovery: Getting this device information
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:28:20 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:28:20 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:28:20 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 30 18:28:22 sibermusic volumio[859]: info: MyVolumio token set successfully
Jan 30 18:28:22 sibermusic volumio[859]: info: MYVOLUMIO: Adding device
Jan 30 18:28:22 sibermusic volumio[859]: info: MYVOLUMIO: Evaluating Server
Jan 30 18:28:22 sibermusic volumio[859]: info: MyVolumio Plan changed: premium
Jan 30 18:28:22 sibermusic volumio[859]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Jan 30 18:28:22 sibermusic volumio[859]: info: Removing browser output: myVolumio user plan is not superstar
Jan 30 18:28:22 sibermusic volumio[859]: info: Removing audio output:
Jan 30 18:28:22 sibermusic volumio[859]: info: MYVOLUMIO: Adding device
Jan 30 18:28:22 sibermusic volumio[859]: info: MYVOLUMIO: Evaluating Server
Jan 30 18:28:22 sibermusic volumio[859]: info: Remote config written successfully
Jan 30 18:28:22 sibermusic volumio[859]: info: Starting Tunnel 1
Jan 30 18:28:22 sibermusic volumio[859]: info: Starting Tunnel Connection Checker
Jan 30 18:28:23 sibermusic volumio[859]: info: MYVolumio Device enabled
Jan 30 18:28:23 sibermusic volumio[859]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Jan 30 18:28:23 sibermusic volumio[859]: info: MyVolumio status changed
Jan 30 18:28:23 sibermusic volumio[859]: info: Streaming services startup
Jan 30 18:28:23 sibermusic volumio[859]: info: Starting Streaming Daemon
Jan 30 18:28:23 sibermusic volumio[859]: info: Setting Geolocation for MyVolumio to eu3
Jan 30 18:28:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:23 sibermusic sudo[1961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jan 30 18:28:23 sibermusic sudo[1961]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:23 sibermusic sudo[1961]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:23 sibermusic volumio[859]: error: Cannot start Volumio Streaming Daemon
Jan 30 18:28:23 sibermusic volumio[859]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jan 30 18:28:23 sibermusic volumio[859]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jan 30 18:28:23 sibermusic volumio[859]: info: Setting Geolocation for MyVolumio to eu2
Jan 30 18:28:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Jan 30 18:28:23 sibermusic volumio[859]: error: [MyVolumio PluginManager] Cache data is invalid!
Jan 30 18:28:23 sibermusic volumio[859]: info: Successfully Added MyVolumio device
Jan 30 18:28:23 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Jan 30 18:28:24 sibermusic volumio[859]: info: [1706635704092] Starting BluetoothController
Jan 30 18:28:24 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Jan 30 18:28:25 sibermusic sudo[1964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Jan 30 18:28:25 sibermusic sudo[1964]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:25 sibermusic sudo[1964]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:25 sibermusic volumio[859]: info: MRS: MultiRoom plugin initialized
Jan 30 18:28:25 sibermusic volumio[859]: info: MRS: STOPPING SNAPCLIENT
Jan 30 18:28:25 sibermusic volumio[859]: info: MRS: Snap server stop
Jan 30 18:28:25 sibermusic sudo[1980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Jan 30 18:28:25 sibermusic sudo[1980]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:25 sibermusic volumio[859]: info: MRS: STOPPING volumioStreaming
Jan 30 18:28:25 sibermusic sudo[1980]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:25 sibermusic sudo[1984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Jan 30 18:28:25 sibermusic sudo[1984]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:25 sibermusic sudo[1986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Jan 30 18:28:25 sibermusic sudo[1986]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:25 sibermusic sudo[1988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Jan 30 18:28:25 sibermusic sudo[1988]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:25 sibermusic sudo[1984]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:25 sibermusic sudo[1988]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Jan 30 18:28:25 sibermusic sudo[1986]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Jan 30 18:28:25 sibermusic volumio[859]: info: Preparing to generate the ALSA configuration file
Jan 30 18:28:25 sibermusic volumio[859]: info: Updating MyVolumio device info
Jan 30 18:28:25 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:25 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:25 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:25 sibermusic volumio[859]: info: Updating MyVolumio device info
Jan 30 18:28:25 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:25 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:25 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:25 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Jan 30 18:28:25 sibermusic volumio[859]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jan 30 18:28:25 sibermusic volumio[859]: info: Reading ALSA contributions from plugins.
Jan 30 18:28:25 sibermusic volumio[859]: info: Successfully Added MyVolumio device
Jan 30 18:28:25 sibermusic volumio[859]: info: MRS: Removed streaming files
Jan 30 18:28:25 sibermusic volumio[859]: info: MRS: volumioStreaming STOPPED
Jan 30 18:28:25 sibermusic volumio[859]: info: MRS: SNAPSERVER STOPPED
Jan 30 18:28:25 sibermusic volumio[859]: info: MRS: SNAPCLIENT STOPPED
Jan 30 18:28:25 sibermusic volumio[859]: info: Asound.conf file written
Jan 30 18:28:25 sibermusic sudo[1992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jan 30 18:28:25 sibermusic sudo[1992]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:25 sibermusic sudo[1992]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:25 sibermusic volumio[859]: info: Output device has changed, restarting MPD
Jan 30 18:28:25 sibermusic sudo[1997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 30 18:28:25 sibermusic sudo[1997]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:25 sibermusic volumio[859]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 30 18:28:25 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:25 sibermusic sudo[1997]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:25 sibermusic sudo[2000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Jan 30 18:28:25 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 30 18:28:25 sibermusic sudo[2000]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:25 sibermusic systemd[1]: musicservicesshield.service: Succeeded.
Jan 30 18:28:25 sibermusic systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Jan 30 18:28:25 sibermusic systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Jan 30 18:28:25 sibermusic systemd[1]: Stopping Music Player Daemon...
Jan 30 18:28:25 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Jan 30 18:28:25 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Jan 30 18:28:25 sibermusic volumio[859]: info: MRS: Pushing multiroomSync output for this device
Jan 30 18:28:25 sibermusic volumio[859]: info: MRS: Pushing multiroomSync output
Jan 30 18:28:25 sibermusic systemd[1]: mpd.service: Succeeded.
Jan 30 18:28:25 sibermusic systemd[1]: Stopped Music Player Daemon.
Jan 30 18:28:25 sibermusic volumio[859]: info: Adding audio output:
Jan 30 18:28:25 sibermusic sudo[2005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name sibermusic
Jan 30 18:28:25 sibermusic sudo[2005]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:26 sibermusic systemd[1]: Starting Music Player Daemon...
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding audio output:
Jan 30 18:28:26 sibermusic volumio[859]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 30 18:28:26 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:26 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding METAVOLUMIO REST API Endpoints
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Jan 30 18:28:26 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding Manifest REST API Endpoints
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui
Jan 30 18:28:26 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Jan 30 18:28:26 sibermusic volumio[859]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting
Jan 30 18:28:26 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding inputs REST Endpoints
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
Jan 30 18:28:26 sibermusic volumio[859]: info: Scanning Audio Inputs
Jan 30 18:28:25 sibermusic sudo[2005]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:26 sibermusic volumio[859]: info: Checking against Known Cards name
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding Server instance for streaming
Jan 30 18:28:26 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Jan 30 18:28:26 sibermusic volumio[859]: error: Hi Res Audio Failed Login: Missing Login Data
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding HIGHRESAUDIO REST API Endpoints
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Jan 30 18:28:26 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Jan 30 18:28:26 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Jan 30 18:28:26 sibermusic volumio[859]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Jan 30 18:28:26 sibermusic volumio[859]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting
Jan 30 18:28:26 sibermusic volumio[859]: info: Stopping AccessToken refresher cron
Jan 30 18:28:26 sibermusic sudo[2006]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 30 18:28:26 sibermusic sudo[2006]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:26 sibermusic sudo[2006]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:26 sibermusic volumio[859]: info: AccessToken refresher cron started
Jan 30 18:28:26 sibermusic volumio[859]: info: Stopping AccessToken refresher cron for QOBUZ
Jan 30 18:28:26 sibermusic volumio[859]: info: AccessToken refresher cron started for QOBUZ
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding TIDAL REST API Endpoints
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding QOBUZ REST API Endpoints
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Jan 30 18:28:26 sibermusic volumio[859]: info: Bluetooth name changed to sibermusic
Jan 30 18:28:26 sibermusic volumio[859]: info: MPD Permissions set
Jan 30 18:28:26 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:26 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:26 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:26 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:26 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:26 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:26 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:26 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:26 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 30 18:28:26 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:26 sibermusic volumio[859]: info: MRS: Adding multiroomSync output
Jan 30 18:28:26 sibermusic volumio[859]: info: Adding audio output:
Jan 30 18:28:26 sibermusic volumio[859]: info: MRS: Pushing multiroomSync output
Jan 30 18:28:26 sibermusic volumio[859]: info: Successfully Updated MyVolumio device
Jan 30 18:28:26 sibermusic mpd[2015]: Jan 30 18:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jan 30 18:28:26 sibermusic systemd[1]: Started Music Player Daemon.
Jan 30 18:28:26 sibermusic sudo[2000]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:26 sibermusic volumio[859]: error: updateQueue error: null
Jan 30 18:28:26 sibermusic systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Jan 30 18:28:27 sibermusic volumio[859]: info: Successfully Updated MyVolumio device
Jan 30 18:28:27 sibermusic volumio[2022]: cset: --> shielding system active with
Jan 30 18:28:27 sibermusic volumio[2022]: cset: "system" cpuset of CPUSPEC(2-3) with 208 tasks running
Jan 30 18:28:27 sibermusic volumio[2022]: cset: "user" cpuset of CPUSPEC(0-1) with 3 tasks running
Jan 30 18:28:27 sibermusic systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Jan 30 18:28:28 sibermusic sudo[2049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Jan 30 18:28:28 sibermusic sudo[2049]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:29 sibermusic systemd[1]: Started Volumio Bluetooth Module.
Jan 30 18:28:29 sibermusic sudo[2049]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:29 sibermusic volumio[859]: info: Volumio BT Module successfully started
Jan 30 18:28:29 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 30 18:28:29 sibermusic volumio[859]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9
Jan 30 18:28:29 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:28:29 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:28:30 sibermusic sudo[2053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Jan 30 18:28:30 sibermusic sudo[2053]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:30 sibermusic volumiobt[2051]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
Jan 30 18:28:30 sibermusic sudo[2053]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:30 sibermusic sshd[2047]: Accepted password for volumio from 192.168.178.66 port 54480 ssh2
Jan 30 18:28:30 sibermusic sshd[2047]: pam_unix(sshd:session): session opened for user volumio by (uid=0)
Jan 30 18:28:30 sibermusic systemd-logind[507]: New session 1 of user volumio.
Jan 30 18:28:30 sibermusic volumio[859]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 30 18:28:30 sibermusic systemd[1]: Created slice User Slice of UID 1000.
Jan 30 18:28:30 sibermusic volumio[859]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 30 18:28:30 sibermusic volumio[859]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 30 18:28:30 sibermusic systemd[1]: Starting User Runtime Directory /run/user/1000...
Jan 30 18:28:30 sibermusic volumio[859]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 30 18:28:30 sibermusic systemd[1]: Started User Runtime Directory /run/user/1000.
Jan 30 18:28:30 sibermusic systemd[1]: Starting User Manager for UID 1000...
Jan 30 18:28:30 sibermusic volumio[859]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 30 18:28:30 sibermusic systemd[2057]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0)
Jan 30 18:28:30 sibermusic volumio[859]: info: MRS: Getting audio outputs on start
Jan 30 18:28:30 sibermusic volumio[859]: info: MRS: Requesting all other devices output
Jan 30 18:28:31 sibermusic sudo[2061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Jan 30 18:28:31 sibermusic sudo[2061]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:31 sibermusic volumiobt[2051]: pulseaudio: no process found
Jan 30 18:28:31 sibermusic sudo[2061]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:31 sibermusic sudo[2070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Jan 30 18:28:31 sibermusic sudo[2070]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:31 sibermusic dbus-daemon[483]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.27' (uid=1000 pid=2075 comm="/usr/bin/pulseaudio --high-priority=true ")
Jan 30 18:28:31 sibermusic systemd[1]: Started MyVolumio SSH Tunnel.
Jan 30 18:28:31 sibermusic systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Jan 30 18:28:31 sibermusic sudo[2070]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:31 sibermusic autossh[2076]: port set to 0, monitoring disabled
Jan 30 18:28:31 sibermusic autossh[2076]: starting ssh (count 1)
Jan 30 18:28:31 sibermusic autossh[2076]: ssh child pid is 2080
Jan 30 18:28:31 sibermusic volumio[859]: info: Remote SSH Started
Jan 30 18:28:31 sibermusic dbus-daemon[483]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Jan 30 18:28:31 sibermusic systemd[1]: Started RealtimeKit Scheduling Policy Service.
Jan 30 18:28:31 sibermusic rtkit-daemon[2079]: Successfully called chroot.
Jan 30 18:28:31 sibermusic rtkit-daemon[2079]: Successfully dropped privileges.
Jan 30 18:28:31 sibermusic rtkit-daemon[2079]: Successfully limited resources.
Jan 30 18:28:31 sibermusic rtkit-daemon[2079]: Running.
Jan 30 18:28:31 sibermusic rtkit-daemon[2079]: Watchdog thread running.
Jan 30 18:28:31 sibermusic rtkit-daemon[2079]: Canary thread running.
Jan 30 18:28:31 sibermusic dbus-daemon[483]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.28' (uid=0 pid=2079 comm="/usr/lib/rtkit/rtkit-daemon ")
Jan 30 18:28:31 sibermusic systemd[1]: Starting Authorization Manager...
Jan 30 18:28:31 sibermusic systemd[2057]: Reached target Paths.
Jan 30 18:28:31 sibermusic systemd[2057]: Starting D-Bus User Message Bus Socket.
Jan 30 18:28:31 sibermusic systemd[2057]: Reached target Timers.
Jan 30 18:28:31 sibermusic systemd[2057]: Listening on Sound System.
Jan 30 18:28:31 sibermusic systemd[2057]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Jan 30 18:28:31 sibermusic systemd[2057]: Listening on GnuPG network certificate management daemon.
Jan 30 18:28:31 sibermusic systemd[2057]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Jan 30 18:28:31 sibermusic systemd[2057]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Jan 30 18:28:31 sibermusic systemd[2057]: Listening on GnuPG cryptographic agent and passphrase cache.
Jan 30 18:28:31 sibermusic systemd[2057]: Listening on D-Bus User Message Bus Socket.
Jan 30 18:28:31 sibermusic systemd[2057]: Reached target Sockets.
Jan 30 18:28:31 sibermusic systemd[2057]: Reached target Basic System.
Jan 30 18:28:31 sibermusic systemd[1]: Started User Manager for UID 1000.
Jan 30 18:28:31 sibermusic systemd[1]: Started Session 1 of user volumio.
Jan 30 18:28:31 sibermusic systemd[2057]: Starting Music Player Daemon...
Jan 30 18:28:31 sibermusic polkitd[2083]: started daemon version 0.105 using authority implementation `local' version `0.105'
Jan 30 18:28:31 sibermusic dbus-daemon[483]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Jan 30 18:28:31 sibermusic systemd[1]: Started Authorization Manager.
Jan 30 18:28:31 sibermusic volumiossh-tunnel[2073]: Warning: Permanently added '[eu2.myvolumio.org]:2222,[185.14.187.123]:2222' (RSA) to the list of known hosts.
Jan 30 18:28:31 sibermusic volumio[859]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 30 18:28:31 sibermusic volumio[859]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 30 18:28:31 sibermusic volumio[859]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 10
Jan 30 18:28:31 sibermusic pulseaudio[2075]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jan 30 18:28:31 sibermusic pulseaudio[2075]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jan 30 18:28:31 sibermusic volumiobt[2051]: Applying permissions
Jan 30 18:28:31 sibermusic volumiobt[2051]: Setting BT discoverable and pairable
Jan 30 18:28:31 sibermusic bluetoothd[590]: Endpoint registered: sender=:1.49 path=/MediaEndpoint/A2DPSource
Jan 30 18:28:31 sibermusic bluetoothd[590]: Endpoint registered: sender=:1.49 path=/MediaEndpoint/A2DPSink
Jan 30 18:28:31 sibermusic pulseaudio[2075]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files
Jan 30 18:28:31 sibermusic kernel: Bluetooth: RFCOMM TTY layer initialized
Jan 30 18:28:31 sibermusic kernel: Bluetooth: RFCOMM socket layer initialized
Jan 30 18:28:31 sibermusic kernel: Bluetooth: RFCOMM ver 1.11
Jan 30 18:28:31 sibermusic sudo[2101]: volumio : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/bash -c touch /testsudo.tmp && rm -rf /testsudo.tmp
Jan 30 18:28:31 sibermusic sudo[2101]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:28:31 sibermusic volumiobt[2051]: Agent registered
Jan 30 18:28:31 sibermusic volumiobt[2051]: [bluetooth]# -e power on
Jan 30 18:28:31 sibermusic volumiobt[2051]: Invalid command in menu main: -e
Jan 30 18:28:31 sibermusic volumiobt[2051]:
Jan 30 18:28:31 sibermusic volumiobt[2051]: Use "help" for a list of available commands in a menu.
Jan 30 18:28:31 sibermusic volumiobt[2051]: Use "menu " if you want to enter any submenu.
Jan 30 18:28:31 sibermusic volumiobt[2051]: Use "back" if you want to return to menu main.
Jan 30 18:28:31 sibermusic volumiobt[2051]: [bluetooth]# agent on
Jan 30 18:28:31 sibermusic volumiobt[2051]: Agent is already registered
Jan 30 18:28:31 sibermusic volumiobt[2051]: [bluetooth]# discoverable on
Jan 30 18:28:31 sibermusic volumiobt[2051]: [bluetooth]# pairable on
Jan 30 18:28:31 sibermusic volumiobt[2051]: [bluetooth]# agent NoInputNoOutput
Jan 30 18:28:31 sibermusic volumiobt[2051]: Agent is already registered
Jan 30 18:28:31 sibermusic volumiobt[2051]: [bluetooth]# default-agent
Jan 30 18:28:31 sibermusic volumiobt[2051]: [bluetooth]# quit
Jan 30 18:28:31 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:28:31 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:28:31 sibermusic volumiobt[2051]: [59B blob data]
Jan 30 18:28:31 sibermusic sudo[2101]: pam_unix(sudo:session): session closed for user root
Jan 30 18:28:32 sibermusic mpd[2088]: exception: failed to open log file "/var/log/mpd.log" (config line 7): Permission denied
Jan 30 18:28:32 sibermusic systemd[2057]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Jan 30 18:28:32 sibermusic systemd[2057]: mpd.service: Failed with result 'exit-code'.
Jan 30 18:28:32 sibermusic systemd[2057]: Failed to start Music Player Daemon.
Jan 30 18:28:32 sibermusic systemd[2057]: Reached target Default.
Jan 30 18:28:32 sibermusic systemd[2057]: Startup finished in 1.806s.
Jan 30 18:28:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 30 18:28:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Jan 30 18:28:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jan 30 18:28:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jan 30 18:28:34 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetBrowseSources
Jan 30 18:28:34 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 30 18:29:45 sibermusic sshd[2133]: Did not receive identification string from 192.168.178.66 port 54490
Jan 30 18:29:46 sibermusic sshd[2096]: Received disconnect from 192.168.178.66 port 54480:11:
Jan 30 18:29:46 sibermusic sshd[2096]: Disconnected from user volumio 192.168.178.66 port 54480
Jan 30 18:29:46 sibermusic sshd[2047]: pam_unix(sshd:session): session closed for user volumio
Jan 30 18:29:46 sibermusic systemd[1]: session-1.scope: Succeeded.
Jan 30 18:29:46 sibermusic systemd-logind[507]: Session 1 logged out. Waiting for processes to exit.
Jan 30 18:29:46 sibermusic systemd-logind[507]: Removed session 1.
Jan 30 18:29:55 sibermusic volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 30 18:29:55 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jan 30 18:29:55 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jan 30 18:29:56 sibermusic volumio[859]: info: Received Get System Version
Jan 30 18:29:56 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 30 18:29:56 sibermusic systemd[1]: Stopping User Manager for UID 1000...
Jan 30 18:29:56 sibermusic systemd[2057]: Stopped target Default.
Jan 30 18:29:56 sibermusic systemd[2057]: Stopped target Basic System.
Jan 30 18:29:56 sibermusic systemd[2057]: Stopped target Timers.
Jan 30 18:29:56 sibermusic systemd[2057]: Stopped target Sockets.
Jan 30 18:29:56 sibermusic systemd[2057]: dbus.socket: Succeeded.
Jan 30 18:29:56 sibermusic systemd[2057]: Closed D-Bus User Message Bus Socket.
Jan 30 18:29:56 sibermusic systemd[2057]: gpg-agent-ssh.socket: Succeeded.
Jan 30 18:29:56 sibermusic systemd[2057]: Closed GnuPG cryptographic agent (ssh-agent emulation).
Jan 30 18:29:56 sibermusic systemd[2057]: gpg-agent-browser.socket: Succeeded.
Jan 30 18:29:56 sibermusic volumio[859]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 30 18:29:56 sibermusic systemd[2057]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
Jan 30 18:29:56 sibermusic systemd[2057]: gpg-agent.socket: Succeeded.
Jan 30 18:29:56 sibermusic systemd[2057]: Closed GnuPG cryptographic agent and passphrase cache.
Jan 30 18:29:56 sibermusic systemd[2057]: gpg-agent-extra.socket: Succeeded.
Jan 30 18:29:56 sibermusic systemd[2057]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
Jan 30 18:29:56 sibermusic systemd[2057]: pulseaudio.socket: Succeeded.
Jan 30 18:29:56 sibermusic systemd[2057]: Closed Sound System.
Jan 30 18:29:56 sibermusic systemd[2057]: dirmngr.socket: Succeeded.
Jan 30 18:29:56 sibermusic systemd[2057]: Closed GnuPG network certificate management daemon.
Jan 30 18:29:56 sibermusic systemd[2057]: Stopped target Paths.
Jan 30 18:29:56 sibermusic systemd[2057]: Reached target Shutdown.
Jan 30 18:29:56 sibermusic systemd[2057]: systemd-exit.service: Succeeded.
Jan 30 18:29:56 sibermusic systemd[2057]: Started Exit the Session.
Jan 30 18:29:56 sibermusic systemd[2057]: Reached target Exit the Session.
Jan 30 18:29:56 sibermusic systemd[1]: user@1000.service: Succeeded.
Jan 30 18:29:56 sibermusic systemd[1]: Stopped User Manager for UID 1000.
Jan 30 18:29:56 sibermusic systemd[1]: Stopping User Runtime Directory /run/user/1000...
Jan 30 18:29:56 sibermusic volumio[859]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 30 18:29:56 sibermusic systemd[1]: run-user-1000.mount: Succeeded.
Jan 30 18:29:56 sibermusic systemd[1]: user-runtime-dir@1000.service: Succeeded.
Jan 30 18:29:56 sibermusic systemd[1]: Stopped User Runtime Directory /run/user/1000.
Jan 30 18:29:56 sibermusic systemd[1]: Removed slice User Slice of UID 1000.
Jan 30 18:30:14 sibermusic volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 30 18:30:14 sibermusic volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 30 18:30:14 sibermusic volumio[859]: info: Retrieving Cloud Streaming UI
Jan 30 18:30:14 sibermusic volumio[859]: info: Getting Tidal Cloud Configuration
Jan 30 18:30:14 sibermusic volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 30 18:30:15 sibermusic volumio[859]: info: Getting Qobuz Cloud Configuration
Jan 30 18:30:15 sibermusic volumio[859]: info: Asking plugin for UI Config
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 30 18:30:15 sibermusic volumio[859]: info: Getting Spotify Cloud Configuration
Jan 30 18:30:15 sibermusic volumio[859]: info: Asking plugin for UI Config
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 30 18:30:15 sibermusic volumio[859]: info: Saving Spotify Acccount
Jan 30 18:30:15 sibermusic volumio[859]: info: Got it
Jan 30 18:30:15 sibermusic volumio[859]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Jan 30 18:30:15 sibermusic volumio[859]: info: Got Tidal Cloud Configuration
Jan 30 18:30:15 sibermusic volumio[859]: info: Got it
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetBrowseSources
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetBrowseSources
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetBrowseSources
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jan 30 18:30:15 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jan 30 18:30:19 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jan 30 18:30:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jan 30 18:30:27 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jan 30 18:31:20 sibermusic sudo[2144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 30 18:31:20 sibermusic sudo[2144]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:31:20 sibermusic sudo[2144]: pam_unix(sudo:session): session closed for user root
Jan 30 18:31:20 sibermusic sudo[2147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 30 18:31:20 sibermusic sudo[2147]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:31:20 sibermusic sudo[2147]: pam_unix(sudo:session): session closed for user root
Jan 30 18:31:20 sibermusic volumio[859]: verbose: New Socket.io Connection to 192.168.178.227 from 192.168.178.123 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36 Total Clients: 10
Jan 30 18:31:21 sibermusic sudo[2150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 30 18:31:21 sibermusic sudo[2150]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:31:21 sibermusic sudo[2150]: pam_unix(sudo:session): session closed for user root
Jan 30 18:31:21 sibermusic sudo[2153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 30 18:31:21 sibermusic sudo[2153]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:31:21 sibermusic sudo[2153]: pam_unix(sudo:session): session closed for user root
Jan 30 18:31:21 sibermusic volumio[859]: verbose: New Socket.io Connection to 192.168.178.227 from 192.168.178.123 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36 Total Clients: 11
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:31:22 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 30 18:31:22 sibermusic volumio[859]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jan 30 18:31:22 sibermusic volumio[859]: info: Received Get System Info
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 30 18:31:22 sibermusic volumio[859]: info: Discovery: Getting this device information
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:31:22 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:31:22 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:31:22 sibermusic volumio[859]: info: Listing playlists
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 30 18:31:22 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:31:22 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:31:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 30 18:31:23 sibermusic volumio[859]: info: Received Get System Info
Jan 30 18:31:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 30 18:31:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 30 18:31:23 sibermusic volumio[859]: info: Discovery: Getting this device information
Jan 30 18:31:23 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:31:23 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:31:23 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 30 18:31:24 sibermusic volumio[859]: info: Executing endpoint metavolumio
Jan 30 18:31:24 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jan 30 18:31:24 sibermusic volumio[859]: info: Executing endpoint metavolumio
Jan 30 18:31:24 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jan 30 18:31:24 sibermusic volumio[859]: info: Executing endpoint metavolumio
Jan 30 18:31:24 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jan 30 18:31:24 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 30 18:31:24 sibermusic volumio[859]: info: Received Get System Info
Jan 30 18:31:24 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 30 18:31:24 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 30 18:31:24 sibermusic volumio[859]: info: Discovery: Getting this device information
Jan 30 18:31:24 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:31:24 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:31:24 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 30 18:31:30 sibermusic volumio[859]: verbose: New Socket.io Connection to 192.168.178.227 from 192.168.178.123 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36 Total Clients: 11
Jan 30 18:31:31 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetState
Jan 30 18:31:31 sibermusic volumio[859]: info: CorePlayQueue::getTrack 0
Jan 30 18:31:31 sibermusic volumio[859]: info: CoreCommandRouter::volumioGetQueue
Jan 30 18:31:31 sibermusic volumio[859]: info: CoreStateMachine::getQueue
Jan 30 18:31:31 sibermusic volumio[859]: info: CorePlayQueue::getQueue
Jan 30 18:31:31 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Jan 30 18:32:28 sibermusic volumio[859]: info: CALLMETHOD: system_controller system sendBugReport [object Object]
Jan 30 18:32:28 sibermusic volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport
Jan 30 18:32:29 sibermusic sudo[2177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig
Jan 30 18:32:29 sibermusic sudo[2177]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 30 18:32:29 sibermusic sudo[2177]: pam_unix(sudo:session): session closed for user root
Jan 30 18:32:29 sibermusic volumio[859]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Jan 30 18:32:29 sibermusic volumio[859]: info: touch_display: Setting screensaver timeout to 0 seconds.
Jan 30 18:32:33 sibermusic sudo[2241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7
Jan 30 18:32:33 sibermusic sudo[2241]: pam_unix(sudo:session): session opened for user root by (uid=0)