-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Tue 2024-05-14 19:17:59 UTC. -- May 14 19:17:13 musik-amp kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled May 14 19:17:13 musik-amp kernel: fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 51, base_baud = 0) is a PL011 rev2 May 14 19:17:13 musik-amp kernel: serial serial0: tty port ttyAMA1 registered May 14 19:17:13 musik-amp kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer May 14 19:17:13 musik-amp kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver May 14 19:17:13 musik-amp kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 May 14 19:17:13 musik-amp kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated May 14 19:17:13 musik-amp kernel: of_cfs_init May 14 19:17:13 musik-amp kernel: of_cfs_init: OK May 14 19:17:13 musik-amp kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA May 14 19:17:13 musik-amp kernel: Freeing unused kernel image (initmem) memory: 2048K May 14 19:17:13 musik-amp kernel: Run /init as init process May 14 19:17:13 musik-amp kernel: with arguments: May 14 19:17:13 musik-amp kernel: /init May 14 19:17:13 musik-amp kernel: splash May 14 19:17:13 musik-amp kernel: with environment: May 14 19:17:13 musik-amp kernel: HOME=/ May 14 19:17:13 musik-amp kernel: TERM=linux May 14 19:17:13 musik-amp kernel: imgpart=/dev/mmcblk0p2 May 14 19:17:13 musik-amp kernel: imgfile=/volumio_current.sqsh May 14 19:17:13 musik-amp kernel: bootdelay=5 May 14 19:17:13 musik-amp kernel: mmc1: new high speed SDIO card at address 0001 May 14 19:17:13 musik-amp kernel: mmc0: new ultra high speed DDR50 SDHC card at address e624 May 14 19:17:13 musik-amp kernel: mmcblk0: mmc0:e624 SC32G 29.7 GiB May 14 19:17:13 musik-amp kernel: mmcblk0: p1 p2 p3 May 14 19:17:13 musik-amp kernel: mmcblk0: mmc0:e624 SC32G 29.7 GiB (quirks 0x00004000) May 14 19:17:13 musik-amp kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd May 14 19:17:13 musik-amp initramfs: Booting Volumio for BCM2711 May 14 19:17:13 musik-amp initramfs: This script mounts rootfs RO with an overlay RW layer. May 14 19:17:13 musik-amp kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 14 19:17:13 musik-amp initramfs: IMGPART=/dev/mmcblk0p2 May 14 19:17:13 musik-amp initramfs: IMGFILE=/volumio_current.sqsh May 14 19:17:13 musik-amp initramfs: Boot delay (except first time) will be 5 seconds May 14 19:17:13 musik-amp initramfs: /dev/mmcblk0p2: May 14 19:17:13 musik-amp kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 May 14 19:17:13 musik-amp kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 May 14 19:17:13 musik-amp kernel: usb 1-1: Product: USB2.0 Hub May 14 19:17:13 musik-amp kernel: EXT4-fs (mmcblk0p2): recovery complete May 14 19:17:13 musik-amp kernel: hub 1-1:1.0: USB hub found May 14 19:17:13 musik-amp kernel: hub 1-1:1.0: 4 ports detected May 14 19:17:13 musik-amp kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. May 14 19:17:13 musik-amp initramfs: Doing a 5 second delay here to give kernel load a headstart May 14 19:17:13 musik-amp kernel: usb 1-1.1: new high-speed USB device number 3 using xhci_hcd May 14 19:17:13 musik-amp kernel: usb 1-1.1: New USB device found, idVendor=13fe, idProduct=4100, bcdDevice= 1.00 May 14 19:17:13 musik-amp kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 May 14 19:17:13 musik-amp kernel: usb 1-1.1: Product: USB DISK 2.0 May 14 19:17:13 musik-amp kernel: usb 1-1.1: Manufacturer: May 14 19:17:13 musik-amp kernel: usb 1-1.1: SerialNumber: 070F34AC3B09C197 May 14 19:17:13 musik-amp kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected May 14 19:17:13 musik-amp kernel: scsi host0: usb-storage 1-1.1:1.0 May 14 19:17:13 musik-amp kernel: usb 1-1.4: new full-speed USB device number 4 using xhci_hcd May 14 19:17:13 musik-amp kernel: usb 1-1.4: New USB device found, idVendor=046d, idProduct=c52b, bcdDevice=24.11 May 14 19:17:13 musik-amp kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 May 14 19:17:13 musik-amp kernel: usb 1-1.4: Product: USB Receiver May 14 19:17:13 musik-amp kernel: usb 1-1.4: Manufacturer: Logitech May 14 19:17:13 musik-amp kernel: input: Logitech USB Receiver as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.0/0003:046D:C52B.0001/input/input0 May 14 19:17:13 musik-amp kernel: hid-generic 0003:046D:C52B.0001: input,hidraw0: USB HID v1.11 Keyboard [Logitech USB Receiver] on usb-0000:01:00.0-1.4/input0 May 14 19:17:13 musik-amp kernel: input: Logitech USB Receiver Mouse as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.1/0003:046D:C52B.0002/input/input1 May 14 19:17:13 musik-amp kernel: input: Logitech USB Receiver Consumer Control as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.1/0003:046D:C52B.0002/input/input2 May 14 19:17:13 musik-amp kernel: input: Logitech USB Receiver System Control as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.1/0003:046D:C52B.0002/input/input3 May 14 19:17:13 musik-amp kernel: hid-generic 0003:046D:C52B.0002: input,hiddev96,hidraw1: USB HID v1.11 Mouse [Logitech USB Receiver] on usb-0000:01:00.0-1.4/input1 May 14 19:17:13 musik-amp kernel: hid-generic 0003:046D:C52B.0003: hiddev97,hidraw2: USB HID v1.11 Device [Logitech USB Receiver] on usb-0000:01:00.0-1.4/input2 May 14 19:17:13 musik-amp kernel: scsi 0:0:0:0: Direct-Access USB DISK 2.0 PMAP PQ: 0 ANSI: 4 May 14 19:17:13 musik-amp kernel: sd 0:0:0:0: [sda] 61820928 512-byte logical blocks: (31.7 GB/29.5 GiB) May 14 19:17:13 musik-amp kernel: sd 0:0:0:0: [sda] Write Protect is off May 14 19:17:13 musik-amp kernel: sd 0:0:0:0: [sda] Mode Sense: 23 00 00 00 May 14 19:17:13 musik-amp kernel: sd 0:0:0:0: [sda] No Caching mode page found May 14 19:17:13 musik-amp kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through May 14 19:17:13 musik-amp kernel: sda: sda1 May 14 19:17:13 musik-amp kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk May 14 19:17:13 musik-amp initramfs: Checking for USB updates May 14 19:17:13 musik-amp kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. May 14 19:17:13 musik-amp kernel: loop0: detected capacity change from 0 to 976664 May 14 19:17:13 musik-amp kernel: EXT4-fs (mmcblk0p3): recovery complete May 14 19:17:13 musik-amp kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. May 14 19:17:13 musik-amp initramfs: With Option: May 14 19:17:13 musik-amp initramfs: VOLUMIO_VERSION="3.661" May 14 19:17:13 musik-amp initramfs: Finish initramfs, continue booting Volumio May 14 19:17:13 musik-amp systemd[1]: System time before build time, advancing clock. May 14 19:17:13 musik-amp kernel: NET: Registered PF_INET6 protocol family May 14 19:17:13 musik-amp kernel: Segment Routing with IPv6 May 14 19:17:13 musik-amp kernel: In-situ OAM (IOAM) with IPv6 May 14 19:17:13 musik-amp 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) May 14 19:17:13 musik-amp systemd[1]: Detected architecture arm. May 14 19:17:13 musik-amp systemd[1]: Set hostname to . May 14 19:17:13 musik-amp 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. May 14 19:17:13 musik-amp systemd[1]: Created slice User and Session Slice. May 14 19:17:13 musik-amp systemd[1]: Reached target Slices. May 14 19:17:13 musik-amp systemd[1]: Created slice system-systemd\x2dfsck.slice. May 14 19:17:13 musik-amp systemd[1]: Listening on Journal Socket (/dev/log). May 14 19:17:13 musik-amp systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. May 14 19:17:13 musik-amp systemd[1]: Created slice system-getty.slice. May 14 19:17:13 musik-amp kernel: i2c_dev: i2c /dev entries driver May 14 19:17:13 musik-amp systemd-journald[215]: Journal started May 14 19:17:13 musik-amp systemd-journald[215]: Runtime journal (/run/log/journal/f67eb8adba804d11b617d1be61ee763c) is 7.5M, max 30.0M, 22.5M free. May 14 19:17:13 musik-amp systemd-modules-load[205]: Inserted module 'i2c_dev' May 14 19:17:13 musik-amp fake-hwclock[206]: Tue May 14 19:17:13 UTC 2024 May 14 19:17:13 musik-amp systemd[1]: Started Restore / save the current clock. May 14 19:17:13 musik-amp systemd[1]: Started Apply Kernel Variables. May 14 19:17:13 musik-amp systemd[1]: Started Load/Save Random Seed. May 14 19:17:13 musik-amp systemd[1]: dynamicswap.service: Succeeded. May 14 19:17:13 musik-amp systemd[1]: Started Create System Users. May 14 19:17:13 musik-amp systemd[1]: Starting Create Static Device Nodes in /dev... May 14 19:17:13 musik-amp systemd[1]: Started udev Coldplug all Devices. May 14 19:17:13 musik-amp systemd[1]: Starting Helper to synchronize boot up for ifupdown... May 14 19:17:13 musik-amp systemd[1]: Started Helper to synchronize boot up for ifupdown. May 14 19:17:13 musik-amp systemd[1]: Started Create Static Device Nodes in /dev. May 14 19:17:13 musik-amp systemd[1]: Starting udev Kernel Device Manager... May 14 19:17:13 musik-amp systemd[1]: Reached target Local File Systems (Pre). May 14 19:17:13 musik-amp systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. May 14 19:17:13 musik-amp systemd[1]: Mounting /var/log... May 14 19:17:13 musik-amp systemd[1]: Mounting /var/spool/cups... May 14 19:17:13 musik-amp systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. May 14 19:17:13 musik-amp systemd[1]: Mounting /tmp... May 14 19:17:13 musik-amp systemd[1]: Mounted /var/log. May 14 19:17:13 musik-amp systemd[1]: Starting Flush Journal to Persistent Storage... May 14 19:17:13 musik-amp systemd[1]: Mounted /var/spool/cups. May 14 19:17:13 musik-amp systemd[1]: Mounted /tmp. May 14 19:17:13 musik-amp systemd-udevd[245]: Network interface NamePolicy= disabled on kernel command line, ignoring. May 14 19:17:13 musik-amp systemd[1]: Mounting /var/spool/cups/tmp... May 14 19:17:13 musik-amp systemd[1]: Mounted /var/spool/cups/tmp. May 14 19:17:13 musik-amp systemd-journald[215]: Runtime journal (/run/log/journal/f67eb8adba804d11b617d1be61ee763c) is 7.5M, max 30.0M, 22.5M free. May 14 19:17:13 musik-amp systemd[1]: Started Flush Journal to Persistent Storage. May 14 19:17:13 musik-amp systemd[1]: Started udev Kernel Device Manager. May 14 19:17:13 musik-amp systemd[1]: Starting Show Plymouth Boot Screen... May 14 19:17:13 musik-amp systemd[1]: Received SIGRTMIN+20 from PID 266 (plymouthd). May 14 19:17:13 musik-amp systemd[1]: Started Show Plymouth Boot Screen. May 14 19:17:13 musik-amp systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. May 14 19:17:13 musik-amp systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 14 19:17:13 musik-amp systemd[1]: Reached target Local Encrypted Volumes. May 14 19:17:13 musik-amp systemd[1]: Reached target Paths. May 14 19:17:13 musik-amp systemd-udevd[254]: Using default interface naming scheme 'v240'. May 14 19:17:13 musik-amp systemd-udevd[254]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 14 19:17:13 musik-amp kernel: mc: Linux media interface: v0.10 May 14 19:17:13 musik-amp kernel: rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000 May 14 19:17:13 musik-amp kernel: rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem May 14 19:17:13 musik-amp kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. May 14 19:17:13 musik-amp kernel: videodev: Linux video capture interface: v2.00 May 14 19:17:13 musik-amp kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver May 14 19:17:13 musik-amp kernel: [vc_sm_connected_init]: start May 14 19:17:13 musik-amp kernel: [vc_sm_connected_init]: installed successfully May 14 19:17:14 musik-amp kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 May 14 19:17:14 musik-amp kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. May 14 19:17:14 musik-amp kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. May 14 19:17:14 musik-amp kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller May 14 19:17:14 musik-amp kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp May 14 19:17:14 musik-amp kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. May 14 19:17:14 musik-amp kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 May 14 19:17:14 musik-amp kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode May 14 19:17:14 musik-amp kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 May 14 19:17:14 musik-amp kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode May 14 19:17:14 musik-amp kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 May 14 19:17:14 musik-amp kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp May 14 19:17:14 musik-amp kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. May 14 19:17:14 musik-amp kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 May 14 19:17:14 musik-amp kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx May 14 19:17:14 musik-amp kernel: rpivid feb10000.codec: Device registered as /dev/video19 May 14 19:17:14 musik-amp kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 May 14 19:17:14 musik-amp kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image May 14 19:17:14 musik-amp kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. May 14 19:17:14 musik-amp kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored May 14 19:17:14 musik-amp kernel: bcm2835_audio bcm2835_audio: card created with 8 channels May 14 19:17:14 musik-amp kernel: input: raspberrypi-ts as /devices/platform/soc/soc:firmware/soc:firmware:touchscreen/input/input5 May 14 19:17:14 musik-amp systemd[1]: Found device /dev/mmcblk0p1. May 14 19:17:14 musik-amp systemd-udevd[255]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 14 19:17:15 musik-amp kernel: logitech-djreceiver 0003:046D:C52B.0003: hiddev96,hidraw0: USB HID v1.11 Device [Logitech USB Receiver] on usb-0000:01:00.0-1.4/input2 May 14 19:17:15 musik-amp kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database May 14 19:17:15 musik-amp kernel: input: Logitech Wireless Device PID:404d Keyboard as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.2/0003:046D:C52B.0003/0003:046D:404D.0004/input/input6 May 14 19:17:15 musik-amp kernel: input: Logitech Wireless Device PID:404d Mouse as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.2/0003:046D:C52B.0003/0003:046D:404D.0004/input/input7 May 14 19:17:15 musik-amp kernel: hid-generic 0003:046D:404D.0004: input,hidraw1: USB HID v1.11 Keyboard [Logitech Wireless Device PID:404d] on usb-0000:01:00.0-1.4/input2:1 May 14 19:17:15 musik-amp kernel: input: Logitech Wireless Device PID:1020 Mouse as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.2/0003:046D:C52B.0003/0003:046D:1020.0005/input/input11 May 14 19:17:15 musik-amp kernel: hid-generic 0003:046D:1020.0005: input,hidraw2: USB HID v1.11 Mouse [Logitech Wireless Device PID:1020] on usb-0000:01:00.0-1.4/input2:2 May 14 19:17:15 musik-amp kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' May 14 19:17:15 musik-amp kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' May 14 19:17:15 musik-amp kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' May 14 19:17:15 musik-amp kernel: Bluetooth: Core ver 2.22 May 14 19:17:15 musik-amp kernel: NET: Registered PF_BLUETOOTH protocol family May 14 19:17:15 musik-amp kernel: Bluetooth: HCI device and connection manager initialized May 14 19:17:15 musik-amp kernel: Bluetooth: HCI socket layer initialized May 14 19:17:15 musik-amp kernel: Bluetooth: L2CAP socket layer initialized May 14 19:17:15 musik-amp kernel: Bluetooth: SCO socket layer initialized May 14 19:17:15 musik-amp kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 May 14 19:17:15 musik-amp kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 May 14 19:17:15 musik-amp kernel: usbcore: registered new interface driver brcmfmac May 14 19:17:15 musik-amp kernel: Bluetooth: HCI UART driver ver 2.3 May 14 19:17:15 musik-amp kernel: Bluetooth: HCI UART protocol H4 registered May 14 19:17:15 musik-amp kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered May 14 19:17:15 musik-amp kernel: Bluetooth: HCI UART protocol Broadcom registered May 14 19:17:15 musik-amp kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator May 14 19:17:15 musik-amp kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator May 14 19:17:15 musik-amp kernel: uart-pl011 fe201000.serial: no DMA platform data May 14 19:17:15 musik-amp 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 May 14 19:17:15 musik-amp systemd-udevd[258]: Using default interface naming scheme 'v240'. May 14 19:17:15 musik-amp systemd-udevd[258]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 14 19:17:15 musik-amp systemd-udevd[255]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 14 19:17:15 musik-amp kernel: snd-rpi-iqaudio-dac soc:sound: snd_rpi_iqaudio_gpio_unmute: un-muting amp using GPIO22 May 14 19:17:16 musik-amp kernel: Bluetooth: hci0: BCM: chip id 107 May 14 19:17:16 musik-amp kernel: Bluetooth: hci0: BCM: features 0x2f May 14 19:17:16 musik-amp kernel: Bluetooth: hci0: BCM4345C0 May 14 19:17:16 musik-amp kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 May 14 19:17:16 musik-amp kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch May 14 19:17:16 musik-amp systemd-udevd[252]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 14 19:17:16 musik-amp systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. May 14 19:17:16 musik-amp kernel: input: Logitech K400 Plus as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.2/0003:046D:C52B.0003/0003:046D:404D.0004/input/input15 May 14 19:17:16 musik-amp kernel: logitech-hidpp-device 0003:046D:404D.0004: input,hidraw1: USB HID v1.11 Keyboard [Logitech K400 Plus] on usb-0000:01:00.0-1.4/input2:1 May 14 19:17:16 musik-amp systemd[1]: Created slice system-bthelper.slice. May 14 19:17:16 musik-amp systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. May 14 19:17:16 musik-amp systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. May 14 19:17:16 musik-amp systemd[1]: Condition check resulted in FUSE Control File System being skipped. May 14 19:17:16 musik-amp systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 14 19:17:16 musik-amp systemd[1]: Condition check resulted in Huge Pages File System being skipped. May 14 19:17:16 musik-amp systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. May 14 19:17:16 musik-amp systemd[1]: Created slice system-systemd\x2dbacklight.slice. May 14 19:17:16 musik-amp kernel: input: Logitech M215 as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.2/0003:046D:C52B.0003/0003:046D:1020.0005/input/input16 May 14 19:17:16 musik-amp kernel: logitech-hidpp-device 0003:046D:1020.0005: input,hidraw2: USB HID v1.11 Mouse [Logitech M215] on usb-0000:01:00.0-1.4/input2:2 May 14 19:17:16 musik-amp systemd[1]: Starting Load/Save Screen Backlight Brightness of backlight:rpi_backlight... May 14 19:17:16 musik-amp systemd[1]: Starting File System Check on /dev/mmcblk0p1... May 14 19:17:16 musik-amp systemd[1]: Starting Load/Save RF Kill Switch Status... May 14 19:17:16 musik-amp systemd[1]: Started Load/Save Screen Backlight Brightness of backlight:rpi_backlight. May 14 19:17:16 musik-amp systemd[1]: Started File System Check Daemon to report status. May 14 19:17:16 musik-amp systemd[1]: Started Load/Save RF Kill Switch Status. May 14 19:17:16 musik-amp systemd-fsck[402]: fsck.fat 4.1 (2017-01-24) May 14 19:17:16 musik-amp systemd-fsck[402]: /dev/mmcblk0p1: 374 files, 33375/46774 clusters May 14 19:17:16 musik-amp systemd[1]: Found device /sys/subsystem/net/devices/wlan0. May 14 19:17:16 musik-amp systemd[1]: Started File System Check on /dev/mmcblk0p1. May 14 19:17:16 musik-amp systemd[1]: Mounting /boot... May 14 19:17:16 musik-amp systemd-udevd[256]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 14 19:17:16 musik-amp kernel: Bluetooth: hci0: BCM: features 0x2f May 14 19:17:16 musik-amp kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ May 14 19:17:16 musik-amp kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 May 14 19:17:16 musik-amp systemd[1]: Mounted /boot. May 14 19:17:16 musik-amp systemd[1]: Reached target Local File Systems. May 14 19:17:16 musik-amp systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... May 14 19:17:16 musik-amp systemd[1]: Starting Raise network interfaces... May 14 19:17:16 musik-amp systemd[1]: Starting Preprocess NFS configuration... May 14 19:17:16 musik-amp systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. May 14 19:17:16 musik-amp systemd[1]: Started ifup for wlan0. May 14 19:17:16 musik-amp systemd[1]: Started ifup for eth0. May 14 19:17:16 musik-amp systemd[1]: Starting Create Volatile Files and Directories... May 14 19:17:16 musik-amp systemd[1]: plymouth-read-write.service: Succeeded. May 14 19:17:16 musik-amp systemd[1]: Started Tell Plymouth To Write Out Runtime Data. May 14 19:17:16 musik-amp systemd[1]: Received SIGRTMIN+20 from PID 266 (plymouthd). May 14 19:17:16 musik-amp systemd[1]: nfs-config.service: Succeeded. May 14 19:17:16 musik-amp systemd[1]: Started Preprocess NFS configuration. May 14 19:17:16 musik-amp systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. May 14 19:17:16 musik-amp systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. May 14 19:17:16 musik-amp systemd[1]: Reached target NFS client services. May 14 19:17:16 musik-amp systemd-udevd[251]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 14 19:17:17 musik-amp systemd-udevd[255]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 14 19:17:17 musik-amp kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 14 19:17:17 musik-amp systemd[1]: Started Create Volatile Files and Directories. May 14 19:17:17 musik-amp kernel: 8021q: 802.1Q VLAN Support v1.8 May 14 19:17:17 musik-amp systemd-udevd[258]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 14 19:17:17 musik-amp kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) May 14 19:17:17 musik-amp kernel: bcmgenet fd580000.ethernet eth0: Link is Down May 14 19:17:17 musik-amp sh[420]: eth0: waiting for carrier May 14 19:17:17 musik-amp dhcpcd[465]: eth0: waiting for carrier May 14 19:17:17 musik-amp sh[418]: wlan0=wlan0 May 14 19:17:17 musik-amp systemd[1]: Started Entropy daemon using the HAVEGE algorithm. May 14 19:17:17 musik-amp systemd[1]: Starting Update UTMP about System Boot/Shutdown... May 14 19:17:17 musik-amp systemd[1]: Condition check resulted in Network Time Synchronization being skipped. May 14 19:17:17 musik-amp systemd[1]: Starting RPC bind portmap service... May 14 19:17:17 musik-amp systemd[1]: Started Update UTMP about System Boot/Shutdown. May 14 19:17:17 musik-amp systemd[1]: Reached target System Initialization. May 14 19:17:17 musik-amp systemd[1]: Started Volumio Splash. May 14 19:17:17 musik-amp systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. May 14 19:17:17 musik-amp systemd[554]: volumiosplash.service: Failed to execute command: No such file or directory May 14 19:17:17 musik-amp systemd[554]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory May 14 19:17:17 musik-amp systemd[1]: Started Daily apt download activities. May 14 19:17:17 musik-amp systemd[1]: Started Daily apt upgrade and clean activities. May 14 19:17:17 musik-amp systemd[1]: Started Daily Cleanup of Temporary Directories. May 14 19:17:17 musik-amp systemd[1]: Started Daily man-db regeneration. May 14 19:17:17 musik-amp systemd[1]: Reached target Timers. May 14 19:17:17 musik-amp systemd[1]: Listening on D-Bus System Message Bus Socket. May 14 19:17:17 musik-amp systemd[1]: Listening on triggerhappy.socket. May 14 19:17:17 musik-amp systemd[1]: Reached target Sockets. May 14 19:17:17 musik-amp systemd[1]: Reached target Basic System. May 14 19:17:17 musik-amp systemd[1]: Started UPnP Renderer front-end to MPD. May 14 19:17:17 musik-amp systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. May 14 19:17:17 musik-amp systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. May 14 19:17:17 musik-amp systemd[1]: Started volumio-remote-updater.service. May 14 19:17:17 musik-amp systemd[1]: Started Volumio Iptables Module. May 14 19:17:17 musik-amp systemd[1]: Started Manage Sound Card State (restore and store). May 14 19:17:17 musik-amp systemd[1]: Starting Save/Restore Sound Card State... May 14 19:17:17 musik-amp alsactl[558]: alsactl 1.1.8 daemon started May 14 19:17:17 musik-amp systemd[1]: Starting Login Service... May 14 19:17:17 musik-amp systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. May 14 19:17:17 musik-amp systemd[1]: Started D-Bus System Message Bus. May 14 19:17:17 musik-amp systemd[1]: Starting WPA supplicant... May 14 19:17:17 musik-amp systemd[1]: Starting Configure Bluetooth Modems connected by UART... May 14 19:17:17 musik-amp systemd[1]: Started Volumio Log Rotation Service. May 14 19:17:17 musik-amp systemd[1]: Starting dhcpcd on all interfaces... May 14 19:17:17 musik-amp systemd[1]: Starting Wireless Services... May 14 19:17:17 musik-amp systemd[1]: Starting triggerhappy global hotkey daemon... May 14 19:17:17 musik-amp systemd[1]: Starting Avahi mDNS/DNS-SD Stack... May 14 19:17:17 musik-amp systemd[1]: Started RPC bind portmap service. May 14 19:17:17 musik-amp systemd[1]: Started Raise network interfaces. May 14 19:17:17 musik-amp systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC May 14 19:17:17 musik-amp systemd[1]: volumiosplash.service: Failed with result 'exit-code'. May 14 19:17:17 musik-amp systemd[1]: Started Save/Restore Sound Card State. May 14 19:17:17 musik-amp systemd[1]: Reached target Sound Card. May 14 19:17:17 musik-amp systemd[1]: Reached target Remote File Systems (Pre). May 14 19:17:17 musik-amp systemd[1]: Reached target Remote File Systems. May 14 19:17:17 musik-amp systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... May 14 19:17:17 musik-amp systemd[1]: Reached target RPC Port Mapper. May 14 19:17:17 musik-amp dhcpcd[565]: Not running dhcpcd because /etc/network/interfaces May 14 19:17:17 musik-amp dhcpcd[565]: defines some interfaces that will use a May 14 19:17:17 musik-amp dhcpcd[565]: DHCP client or static address May 14 19:17:17 musik-amp thd[567]: Unable to parse trigger line: May 14 19:17:17 musik-amp thd[567]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle May 14 19:17:17 musik-amp thd[567]: Unable to parse trigger line: May 14 19:17:17 musik-amp thd[567]: Found socket passed from systemd May 14 19:17:17 musik-amp systemd-logind[560]: Watching system buttons on /dev/input/event1 (Logitech K400 Plus) May 14 19:17:17 musik-amp systemd-logind[560]: New seat seat0. May 14 19:17:18 musik-amp avahi-daemon[568]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). May 14 19:17:18 musik-amp avahi-daemon[568]: Successfully dropped root privileges. May 14 19:17:18 musik-amp avahi-daemon[568]: avahi-daemon 0.7 starting up. May 14 19:17:18 musik-amp systemd[1]: Started Login Service. May 14 19:17:18 musik-amp systemd[1]: Started triggerhappy global hotkey daemon. May 14 19:17:18 musik-amp avahi-daemon[568]: Successfully called chroot(). May 14 19:17:18 musik-amp avahi-daemon[568]: Successfully dropped remaining capabilities. May 14 19:17:18 musik-amp systemd[1]: hciuart.service: Succeeded. May 14 19:17:18 musik-amp systemd[1]: Started Configure Bluetooth Modems connected by UART. May 14 19:17:18 musik-amp wpa_supplicant[562]: Successfully initialized wpa_supplicant May 14 19:17:18 musik-amp systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED May 14 19:17:18 musik-amp systemd[1]: dhcpcd.service: Failed with result 'exit-code'. May 14 19:17:18 musik-amp systemd[1]: Failed to start dhcpcd on all interfaces. May 14 19:17:18 musik-amp avahi-daemon[568]: Loading service file /services/volumio.service. May 14 19:17:18 musik-amp avahi-daemon[568]: Network interface enumeration completed. May 14 19:17:18 musik-amp avahi-daemon[568]: Server startup complete. Host name is musik-amp.local. Local service cookie is 2131899200. May 14 19:17:18 musik-amp avahi-daemon[568]: Service "Musik amp" (/services/volumio.service) successfully established. May 14 19:17:18 musik-amp systemd[1]: Started WPA supplicant. May 14 19:17:18 musik-amp systemd[1]: Started Avahi mDNS/DNS-SD Stack. May 14 19:17:18 musik-amp systemd[1]: Reached target Network. May 14 19:17:18 musik-amp systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. May 14 19:17:18 musik-amp systemd[1]: Reached target Network is Online. May 14 19:17:18 musik-amp volumio-remote-updater[556]: Error: No active session May 14 19:17:18 musik-amp volumio-remote-updater[556]: [2024-05-14 19:17:18] [info] asio async_connect error: system:111 (Connection refused) May 14 19:17:18 musik-amp volumio-remote-updater[556]: [2024-05-14 19:17:18] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 14 19:17:18 musik-amp volumio-remote-updater[556]: [2024-05-14 19:17:18] [error] handle_connect error: Underlying Transport Error May 14 19:17:18 musik-amp systemd[1]: Starting LSB: Brings up/down network automatically... May 14 19:17:18 musik-amp systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 14 19:17:18 musik-amp systemd[1]: Starting Network Time Service... May 14 19:17:18 musik-amp systemd[1]: Starting Permit User Sessions... May 14 19:17:18 musik-amp volumio[555]: Could not open config: /tmp/upmpdcli.conf May 14 19:17:18 musik-amp systemd[1]: Starting Samba NMB Daemon... May 14 19:17:18 musik-amp systemd[1]: Starting /etc/rc.local Compatibility... May 14 19:17:18 musik-amp systemd[1]: Starting Raspberry Pi bluetooth helper... May 14 19:17:18 musik-amp systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 14 19:17:18 musik-amp systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 14 19:17:18 musik-amp systemd[1]: Started Permit User Sessions. May 14 19:17:18 musik-amp systemd[1]: Started /etc/rc.local Compatibility. May 14 19:17:18 musik-amp bthelper[618]: Raspberry Pi BDADDR already set May 14 19:17:18 musik-amp ntpd[605]: ntpd 4.2.8p12@1.3728-o (1): Starting May 14 19:17:18 musik-amp ntpd[605]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 May 14 19:17:18 musik-amp systemd[1]: Starting Terminate Plymouth Boot Screen... May 14 19:17:18 musik-amp systemd[1]: Starting Hold until boot process finishes up... May 14 19:17:18 musik-amp systemd[1]: Started Network Time Service. May 14 19:17:18 musik-amp systemd[1]: plymouth-start.service: Succeeded. May 14 19:17:18 musik-amp ntpd[647]: proto: precision = 4.074 usec (-18) May 14 19:17:18 musik-amp systemd[1]: Started Raspberry Pi bluetooth helper. May 14 19:17:18 musik-amp ntpd[647]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 14 19:17:18 musik-amp ntpd[647]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 14 19:17:18 musik-amp systemd[1]: plymouth-quit.service: Succeeded. May 14 19:17:18 musik-amp ntpd[647]: Listen and drop on 0 v6wildcard [::]:123 May 14 19:17:18 musik-amp systemd[1]: Started Terminate Plymouth Boot Screen. May 14 19:17:18 musik-amp ntpd[647]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 14 19:17:18 musik-amp ntpd[647]: Listen normally on 2 lo 127.0.0.1:123 May 14 19:17:18 musik-amp ntpd[647]: Listening on routing socket on fd #19 for interface updates May 14 19:17:18 musik-amp ntpd[647]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 14 19:17:18 musik-amp ntpd[647]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 14 19:17:18 musik-amp systemd[1]: plymouth-quit-wait.service: Succeeded. May 14 19:17:19 musik-amp systemd[1]: Started Hold until boot process finishes up. May 14 19:17:19 musik-amp systemd[1]: Received SIGRTMIN+21 from PID 266 (n/a). May 14 19:17:19 musik-amp systemd[1]: Received SIGRTMIN+21 from PID 266 (n/a). May 14 19:17:19 musik-amp loadcpufreq[570]: Loading cpufreq kernel modules...done (none). May 14 19:17:19 musik-amp systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. May 14 19:17:19 musik-amp systemd[1]: Starting LSB: set CPUFreq kernel parameters... May 14 19:17:19 musik-amp systemd[1]: Started Getty on tty1. May 14 19:17:19 musik-amp systemd[1]: Reached target Login Prompts. May 14 19:17:19 musik-amp systemd[1]: Starting Bluetooth service... May 14 19:17:19 musik-amp ifplugd(eth0)[672]: ifplugd 0.28 initializing. May 14 19:17:19 musik-amp ifplugd(eth0)[672]: Using interface eth0/E4:5F:01:41:66:67 with driver (version: 6.1.69-v7l+) May 14 19:17:19 musik-amp ifplugd(eth0)[672]: Using detection mode: SIOCETHTOOL May 14 19:17:19 musik-amp ifplugd(eth0)[672]: Initialization complete, link beat not detected. May 14 19:17:19 musik-amp ifplugd[595]: Network Interface Plugging Daemon...start eth0...done. May 14 19:17:19 musik-amp systemd[1]: Started LSB: Brings up/down network automatically. May 14 19:17:19 musik-amp bluetoothd[668]: Bluetooth daemon 5.50 May 14 19:17:19 musik-amp systemd[1]: iptables.service: Succeeded. May 14 19:17:19 musik-amp bluetoothd[668]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf May 14 19:17:19 musik-amp systemd[1]: Started Bluetooth service. May 14 19:17:19 musik-amp systemd[1]: Reached target Bluetooth. May 14 19:17:19 musik-amp bluetoothd[668]: Starting SDP server May 14 19:17:19 musik-amp cpufrequtils[655]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. May 14 19:17:19 musik-amp systemd[1]: Started LSB: set CPUFreq kernel parameters. May 14 19:17:19 musik-amp bluetoothd[668]: Bluetooth management interface 1.22 initialized May 14 19:17:19 musik-amp dbus-daemon[561]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=668 comm="/usr/lib/bluetooth/bluetoothd ") May 14 19:17:19 musik-amp kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 May 14 19:17:19 musik-amp kernel: Bluetooth: BNEP filters: protocol multicast May 14 19:17:19 musik-amp kernel: Bluetooth: BNEP socket layer initialized May 14 19:17:19 musik-amp kernel: Bluetooth: MGMT ver 1.22 May 14 19:17:19 musik-amp bluetoothd[668]: Sap driver initialization failed. May 14 19:17:19 musik-amp bluetoothd[668]: sap-server: Operation not permitted (1) May 14 19:17:19 musik-amp systemd[1]: Starting Hostname Service... May 14 19:17:19 musik-amp bluetoothd[668]: Failed to set privacy: Rejected (0x0b) May 14 19:17:19 musik-amp dbus-daemon[561]: [system] Successfully activated service 'org.freedesktop.hostname1' May 14 19:17:19 musik-amp systemd[1]: Started Hostname Service. May 14 19:17:19 musik-amp nmbd[624]: [2024/05/14 19:17:19.894642, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) May 14 19:17:19 musik-amp nmbd[624]: started asyncdns process 691 May 14 19:17:19 musik-amp nmbd[624]: [2024/05/14 19:17:19.896899, 0] ../lib/util/become_daemon.c:149(daemon_status) May 14 19:17:19 musik-amp nmbd[624]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... May 14 19:17:19 musik-amp nmbd[624]: [2024/05/14 19:17:19.897037, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) May 14 19:17:19 musik-amp nmbd[624]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). May 14 19:17:19 musik-amp ntpd[647]: error resolving pool 0.debian.pool.ntp.org: System error (-11) May 14 19:17:20 musik-amp haveged[539]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K May 14 19:17:20 musik-amp haveged[539]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 May 14 19:17:20 musik-amp haveged[539]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99689 May 14 19:17:20 musik-amp haveged[539]: haveged: fills: 0, generated: 0 May 14 19:17:20 musik-amp wireless.js[566]: Cleaning previous... May 14 19:17:20 musik-amp sudo[699]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 14 19:17:20 musik-amp sudo[699]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:20 musik-amp sudo[699]: pam_unix(sudo:session): session closed for user root May 14 19:17:20 musik-amp sudo[701]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 14 19:17:20 musik-amp sudo[701]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:20 musik-amp sudo[701]: pam_unix(sudo:session): session closed for user root May 14 19:17:20 musik-amp ntpd[647]: error resolving pool 1.debian.pool.ntp.org: System error (-11) May 14 19:17:20 musik-amp wireless.js[566]: Stopped aP May 14 19:17:20 musik-amp sudo[708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 14 19:17:20 musik-amp sudo[708]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:20 musik-amp sudo[708]: pam_unix(sudo:session): session closed for user root May 14 19:17:20 musik-amp kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 14 19:17:21 musik-amp sudo[710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 14 19:17:21 musik-amp sudo[710]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:21 musik-amp sudo[710]: pam_unix(sudo:session): session closed for user root May 14 19:17:21 musik-amp sudo[717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 14 19:17:21 musik-amp sudo[717]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:21 musik-amp sudo[717]: pam_unix(sudo:session): session closed for user root May 14 19:17:21 musik-amp sudo[719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 14 19:17:21 musik-amp sudo[719]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:21 musik-amp systemd[1]: systemd-rfkill.service: Succeeded. May 14 19:17:21 musik-amp ntpd[647]: error resolving pool 2.debian.pool.ntp.org: System error (-11) May 14 19:17:22 musik-amp ntpd[647]: error resolving pool 3.debian.pool.ntp.org: System error (-11) May 14 19:17:23 musik-amp volumio-remote-updater[556]: [2024-05-14 19:17:23] [info] asio async_connect error: system:111 (Connection refused) May 14 19:17:23 musik-amp volumio-remote-updater[556]: [2024-05-14 19:17:23] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 14 19:17:23 musik-amp volumio-remote-updater[556]: [2024-05-14 19:17:23] [error] handle_connect error: Underlying Transport Error May 14 19:17:23 musik-amp sudo[719]: pam_unix(sudo:session): session closed for user root May 14 19:17:23 musik-amp wireless.js[566]: SETTING APPROPRIATE REG DOMAIN: DK May 14 19:17:23 musik-amp sudo[724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 14 19:17:23 musik-amp sudo[724]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:23 musik-amp sudo[724]: pam_unix(sudo:session): session closed for user root May 14 19:17:23 musik-amp sudo[726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DK May 14 19:17:23 musik-amp sudo[726]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:23 musik-amp sudo[726]: pam_unix(sudo:session): session closed for user root May 14 19:17:23 musik-amp wireless.js[566]: SUCCESSFULLY SET NEW REGDOMAIN: DK May 14 19:17:23 musik-amp wireless.js[566]: Start wireless flow May 14 19:17:23 musik-amp wireless.js[566]: Stopped hotspot (if there).. May 14 19:17:23 musik-amp sudo[731]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 14 19:17:23 musik-amp sudo[731]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:23 musik-amp sudo[731]: pam_unix(sudo:session): session closed for user root May 14 19:17:23 musik-amp sudo[733]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 14 19:17:23 musik-amp sudo[733]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:23 musik-amp bthelper[618]: Changing power off succeeded May 14 19:17:24 musik-amp bthelper[618]: [CHG] Controller E4:5F:01:41:66:6B Class: 0x0000041c May 14 19:17:24 musik-amp bthelper[618]: Changing power on succeeded May 14 19:17:24 musik-amp sudo[733]: pam_unix(sudo:session): session closed for user root May 14 19:17:24 musik-amp wireless.js[566]: DHCP IP May 14 19:17:24 musik-amp wireless.js[566]: Start ap May 14 19:17:24 musik-amp wpa_supplicant[742]: Successfully initialized wpa_supplicant May 14 19:17:24 musik-amp sudo[743]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd May 14 19:17:24 musik-amp sudo[743]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:24 musik-amp kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 14 19:17:24 musik-amp dhcpcd[744]: dev: loaded udev May 14 19:17:24 musik-amp dhcpcd-run-hooks[762]: wlan0: starting wpa_supplicant May 14 19:17:24 musik-amp dhcpcd-run-hooks[767]: wlan0: failed to start wpa_supplicant May 14 19:17:24 musik-amp dhcpcd-run-hooks[768]: 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 May 14 19:17:24 musik-amp dhcpcd[744]: wlan0: connected to Access Point `' May 14 19:17:24 musik-amp dhcpcd[744]: no interfaces have a carrier May 14 19:17:24 musik-amp dhcpcd[744]: forked to background, child pid 778 May 14 19:17:24 musik-amp dhcpcd[778]: eth0: waiting for carrier May 14 19:17:24 musik-amp dhcpcd[778]: wlan0: waiting for carrier May 14 19:17:24 musik-amp sudo[743]: pam_unix(sudo:session): session closed for user root May 14 19:17:25 musik-amp wireless.js[566]: trying... May 14 19:17:25 musik-amp sudo[780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 19:17:25 musik-amp sudo[780]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:25 musik-amp sudo[780]: pam_unix(sudo:session): session closed for user root May 14 19:17:26 musik-amp wireless.js[566]: trying... May 14 19:17:26 musik-amp sudo[783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 19:17:26 musik-amp sudo[783]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:26 musik-amp sudo[783]: pam_unix(sudo:session): session closed for user root May 14 19:17:27 musik-amp wpa_supplicant[766]: wlan0: Trying to associate with SSID 'Linka' May 14 19:17:27 musik-amp wireless.js[566]: trying... May 14 19:17:27 musik-amp sudo[786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 19:17:27 musik-amp sudo[786]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:27 musik-amp sudo[786]: pam_unix(sudo:session): session closed for user root May 14 19:17:28 musik-amp wireless.js[566]: trying... May 14 19:17:28 musik-amp sudo[789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 19:17:28 musik-amp sudo[789]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:28 musik-amp sudo[789]: pam_unix(sudo:session): session closed for user root May 14 19:17:29 musik-amp wireless.js[566]: trying... May 14 19:17:29 musik-amp sudo[792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 19:17:29 musik-amp sudo[792]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:29 musik-amp sudo[792]: pam_unix(sudo:session): session closed for user root May 14 19:17:29 musik-amp dhcpcd[778]: wlan0: carrier acquired May 14 19:17:29 musik-amp dhcpcd[778]: wlan0: connected to Access Point `Linka' May 14 19:17:29 musik-amp wpa_supplicant[766]: wlan0: Associated with 74:ac:b9:37:bf:85 May 14 19:17:29 musik-amp wpa_supplicant[766]: wlan0: CTRL-EVENT-CONNECTED - Connection to 74:ac:b9:37:bf:85 completed [id=0 id_str=] May 14 19:17:29 musik-amp wpa_supplicant[766]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 14 19:17:29 musik-amp wpa_supplicant[766]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DK May 14 19:17:29 musik-amp dhcpcd[778]: DUID 00:01:00:01:29:81:36:ad:e4:5f:01:41:66:69 May 14 19:17:29 musik-amp dhcpcd[778]: wlan0: IAID 01:41:66:69 May 14 19:17:29 musik-amp dhcpcd[778]: wlan0: adding address fe80::76fc:e3f3:5b77:2c2e May 14 19:17:29 musik-amp dhcpcd[778]: ipv6_addaddr1: Permission denied May 14 19:17:29 musik-amp dhcpcd[778]: wlan0: carrier lost May 14 19:17:29 musik-amp dhcpcd[778]: wlan0: carrier acquired May 14 19:17:29 musik-amp dhcpcd[778]: wlan0: IAID 01:41:66:69 May 14 19:17:30 musik-amp dhcpcd[778]: wlan0: soliciting an IPv6 router May 14 19:17:30 musik-amp wireless.js[566]: trying... May 14 19:17:30 musik-amp sudo[807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 19:17:30 musik-amp sudo[807]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:30 musik-amp sudo[807]: pam_unix(sudo:session): session closed for user root May 14 19:17:30 musik-amp dhcpcd[778]: wlan0: rebinding lease of 192.168.1.175 May 14 19:17:30 musik-amp dhcpcd[778]: wlan0: probing address 192.168.1.175/24 May 14 19:17:30 musik-amp volumio-remote-updater[556]: [2024-05-14 19:17:30] [info] asio async_connect error: system:111 (Connection refused) May 14 19:17:31 musik-amp volumio-remote-updater[556]: [2024-05-14 19:17:30] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 14 19:17:31 musik-amp volumio-remote-updater[556]: [2024-05-14 19:17:30] [error] handle_connect error: Underlying Transport Error May 14 19:17:31 musik-amp wireless.js[566]: trying... May 14 19:17:31 musik-amp sudo[810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 19:17:31 musik-amp sudo[810]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:31 musik-amp sudo[810]: pam_unix(sudo:session): session closed for user root May 14 19:17:32 musik-amp wireless.js[566]: trying... May 14 19:17:32 musik-amp sudo[813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 19:17:32 musik-amp sudo[813]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:32 musik-amp sudo[813]: pam_unix(sudo:session): session closed for user root May 14 19:17:33 musik-amp wireless.js[566]: trying... May 14 19:17:33 musik-amp sudo[816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 19:17:33 musik-amp sudo[816]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:33 musik-amp sudo[816]: pam_unix(sudo:session): session closed for user root May 14 19:17:34 musik-amp wireless.js[566]: trying... May 14 19:17:34 musik-amp sudo[819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 19:17:34 musik-amp sudo[819]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:34 musik-amp sudo[819]: pam_unix(sudo:session): session closed for user root May 14 19:17:35 musik-amp dhcpcd[778]: wlan0: leased 192.168.1.175 for 86400 seconds May 14 19:17:35 musik-amp avahi-daemon[568]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.175. May 14 19:17:35 musik-amp avahi-daemon[568]: New relevant interface wlan0.IPv4 for mDNS. May 14 19:17:35 musik-amp avahi-daemon[568]: Registering new address record for 192.168.1.175 on wlan0.IPv4. May 14 19:17:35 musik-amp dhcpcd[778]: wlan0: adding route to 192.168.1.0/24 May 14 19:17:35 musik-amp dhcpcd[778]: wlan0: adding default route via 192.168.1.1 May 14 19:17:35 musik-amp wireless.js[566]: trying... May 14 19:17:35 musik-amp sudo[839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 19:17:35 musik-amp sudo[839]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:35 musik-amp sudo[839]: pam_unix(sudo:session): session closed for user root May 14 19:17:35 musik-amp wireless.js[566]: Connected to: ----Linka May 14 19:17:35 musik-amp wireless.js[566]: ---- May 14 19:17:35 musik-amp sudo[846]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 14 19:17:35 musik-amp sudo[846]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:35 musik-amp sudo[846]: pam_unix(sudo:session): session closed for user root May 14 19:17:35 musik-amp wireless.js[566]: ... joined AP, wlan0 IPv4 is 192.168.1.175, ipV6 is undefined May 14 19:17:35 musik-amp wireless.js[566]: It's done! AP May 14 19:17:35 musik-amp systemd[1]: Started Wireless Services. May 14 19:17:35 musik-amp kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 14 19:17:35 musik-amp systemd[1]: Started Volumio Backend Module. May 14 19:17:35 musik-amp systemd[1]: Started Volumio Cpu Tweaker. May 14 19:17:35 musik-amp volumio-cpu-tweak[852]: Setting RT Priority for mpd May 14 19:17:35 musik-amp volumio-cpu-tweak[852]: pid 35's current scheduling policy: SCHED_OTHER May 14 19:17:35 musik-amp volumio-cpu-tweak[852]: pid 35's current scheduling priority: 0 May 14 19:17:35 musik-amp volumio-cpu-tweak[852]: Setting MPD Affinity May 14 19:17:35 musik-amp volumio-cpu-tweak[852]: pid 3's current affinity mask: f May 14 19:17:35 musik-amp volumio-cpu-tweak[852]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 14 19:17:35 musik-amp volumio-cpu-tweak[852]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 14 19:17:35 musik-amp systemd[1]: volumio_cpu_tweak.service: Succeeded. May 14 19:17:36 musik-amp ntpd[647]: Listen normally on 3 wlan0 192.168.1.175:123 May 14 19:17:36 musik-amp ntpd[647]: new interface(s) found: waking up resolver May 14 19:17:37 musik-amp volumio[851]: info: ------------------------------------------- May 14 19:17:37 musik-amp volumio[851]: info: ----- Volumio3 ---- May 14 19:17:37 musik-amp volumio[851]: info: ------------------------------------------- May 14 19:17:37 musik-amp volumio[851]: info: ----- System startup ---- May 14 19:17:37 musik-amp volumio[851]: info: ------------------------------------------- May 14 19:17:38 musik-amp volumio[851]: info: MYVOLUMIO Environment detected May 14 19:17:38 musik-amp volumio[851]: info: Plugin folders cleanup May 14 19:17:38 musik-amp volumio[851]: info: Scanning into folder /volumio/app/plugins/ May 14 19:17:38 musik-amp volumio[851]: info: Scanning category audio_interface May 14 19:17:38 musik-amp volumio[851]: info: Scanning category miscellanea May 14 19:17:38 musik-amp volumio[851]: info: Scanning category music_service May 14 19:17:38 musik-amp volumio[851]: info: Scanning category plugins.json May 14 19:17:38 musik-amp volumio[851]: info: Scanning category system_controller May 14 19:17:38 musik-amp volumio[851]: info: Scanning category user_interface May 14 19:17:38 musik-amp volumio[851]: info: Scanning into folder /data/plugins/ May 14 19:17:38 musik-amp volumio[851]: info: Scanning category audio_interface May 14 19:17:38 musik-amp volumio[851]: info: Scanning category user_interface May 14 19:17:38 musik-amp volumio[851]: info: Plugin folders cleanup completed May 14 19:17:38 musik-amp volumio[851]: info: ------------------------------------------- May 14 19:17:38 musik-amp volumio[851]: info: ----- Core plugins startup ---- May 14 19:17:38 musik-amp volumio[851]: info: ------------------------------------------- May 14 19:17:38 musik-amp volumio[851]: info: Loading plugins from folder /volumio/app/plugins/ May 14 19:17:38 musik-amp volumio[851]: info: Adding plugin upnp to MyMusic Plugins May 14 19:17:38 musik-amp volumio[851]: info: Adding plugin airplay_emulation to MyMusic Plugins May 14 19:17:38 musik-amp volumio[851]: info: Adding plugin upnp_browser to MyMusic Plugins May 14 19:17:38 musik-amp volumio[851]: info: Loading plugins from folder /data/plugins/ May 14 19:17:38 musik-amp volumio[851]: info: Loading plugin "system"... May 14 19:17:38 musik-amp volumio[851]: info: Loading plugin "appearance"... May 14 19:17:39 musik-amp volumio[851]: info: Loading plugin "network"... May 14 19:17:39 musik-amp volumio[851]: info: Refreshing Cached IP Addresses May 14 19:17:39 musik-amp sudo[882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 14 19:17:39 musik-amp sudo[882]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:39 musik-amp sudo[882]: pam_unix(sudo:session): session closed for user root May 14 19:17:39 musik-amp sudo[884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 14 19:17:39 musik-amp volumio[851]: info: Loading plugin "services"... May 14 19:17:39 musik-amp sudo[884]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:39 musik-amp volumio[851]: info: Loading plugin "alsa_controller"... May 14 19:17:39 musik-amp sudo[884]: pam_unix(sudo:session): session closed for user root May 14 19:17:39 musik-amp sudo[887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 14 19:17:39 musik-amp sudo[887]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:39 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 14 19:17:39 musik-amp volumio[851]: info: Loading plugin "wizard"... May 14 19:17:39 musik-amp volumio[851]: info: Loading plugin "networkfs"... May 14 19:17:39 musik-amp volumio[851]: info: Starting Udev Watcher for removable devices May 14 19:17:39 musik-amp sudo[895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=musik,password=1avminARM?,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.10/musik /mnt/NAS/Musik May 14 19:17:39 musik-amp sudo[895]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:39 musik-amp volumio[851]: info: Ignoring mount for partition: boot May 14 19:17:39 musik-amp volumio[851]: info: Ignoring mount for partition: volumio May 14 19:17:39 musik-amp volumio[851]: info: Ignoring mount for partition: volumio_data May 14 19:17:39 musik-amp volumio[851]: info: Mounting Device USB_DISK May 14 19:17:39 musik-amp sudo[906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/USB_DISK -o noatime,dmask=0000,fmask=0000,iocharset=utf8 May 14 19:17:39 musik-amp sudo[906]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:39 musik-amp kernel: Key type cifs.spnego registered May 14 19:17:39 musik-amp kernel: Key type cifs.idmap registered May 14 19:17:39 musik-amp 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. May 14 19:17:39 musik-amp kernel: CIFS: Attempting to mount \\192.168.1.10\musik May 14 19:17:39 musik-amp sudo[906]: pam_unix(sudo:session): session closed for user root May 14 19:17:39 musik-amp kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! May 14 19:17:39 musik-amp kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. May 14 19:17:39 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 14 19:17:39 musik-amp volumio[851]: info: Loading plugin "volumio_command_line_client"... May 14 19:17:39 musik-amp volumio[851]: info: Loading plugin "upnp"... May 14 19:17:39 musik-amp volumio[851]: info: [1715714259578] Starting Upmpd Daemon May 14 19:17:39 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 14 19:17:39 musik-amp volumio[851]: info: Loading plugin "my_music"... May 14 19:17:39 musik-amp volumio[851]: info: Loading plugin "mpd"... May 14 19:17:39 musik-amp nmbd[624]: [2024/05/14 19:17:39.904013, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 14 19:17:39 musik-amp nmbd[624]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 14 19:17:39 musik-amp systemd[1]: Started Samba NMB Daemon. May 14 19:17:39 musik-amp volumio[851]: info: Loading plugin "upnp_browser"... May 14 19:17:39 musik-amp systemd[1]: Starting Samba Winbind Daemon... May 14 19:17:40 musik-amp sudo[895]: pam_unix(sudo:session): session closed for user root May 14 19:17:40 musik-amp winbindd[926]: [2024/05/14 19:17:40.196338, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 14 19:17:40 musik-amp winbindd[926]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 14 19:17:40 musik-amp winbindd[926]: [2024/05/14 19:17:40.217168, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 14 19:17:40 musik-amp systemd[1]: Started Samba Winbind Daemon. May 14 19:17:40 musik-amp winbindd[926]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "alarm-clock"... May 14 19:17:40 musik-amp systemd[1]: Starting Samba SMB Daemon... May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "airplay_emulation"... May 14 19:17:40 musik-amp volumio[851]: info: Starting Shairport Sync May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "last_100"... May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "webradio"... May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "i2s_dacs"... May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "volumiodiscovery"... May 14 19:17:40 musik-amp smbd[931]: [2024/05/14 19:17:40.631605, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 14 19:17:40 musik-amp smbd[931]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 14 19:17:40 musik-amp systemd[1]: Started Samba SMB Daemon. May 14 19:17:40 musik-amp systemd[1]: Reached target Multi-User System. May 14 19:17:40 musik-amp systemd[1]: Reached target Graphical Interface. May 14 19:17:40 musik-amp volumio[851]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 14 19:17:40 musik-amp node[851]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 14 19:17:40 musik-amp volumio[851]: *** WARNING *** Please fix your application to use the native API of Avahi! May 14 19:17:40 musik-amp node[851]: *** WARNING *** Please fix your application to use the native API of Avahi! May 14 19:17:40 musik-amp volumio[851]: *** WARNING *** For more information see May 14 19:17:40 musik-amp node[851]: *** WARNING *** For more information see May 14 19:17:40 musik-amp volumio[851]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 14 19:17:40 musik-amp node[851]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 14 19:17:40 musik-amp volumio[851]: *** WARNING *** Please fix your application to use the native API of Avahi! May 14 19:17:40 musik-amp node[851]: *** WARNING *** Please fix your application to use the native API of Avahi! May 14 19:17:40 musik-amp volumio[851]: *** WARNING *** For more information see May 14 19:17:40 musik-amp node[851]: *** WARNING *** For more information see May 14 19:17:40 musik-amp volumio[851]: info: Applying required configuration parameters for plugin volumiodiscovery May 14 19:17:40 musik-amp volumio[851]: info: Discovery: Started advertising with name: Musik amp May 14 19:17:40 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "outputs"... May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "albumart"... May 14 19:17:40 musik-amp systemd[1]: Starting Update UTMP about System Runlevel Changes... May 14 19:17:40 musik-amp volumio[851]: info: Plugin example_plugin is not enabled May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "inputs"... May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "updater_comm"... May 14 19:17:40 musik-amp systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 14 19:17:40 musik-amp systemd[1]: Started Update UTMP about System Runlevel Changes. May 14 19:17:40 musik-amp systemd[1]: Startup finished in 9.253s (kernel) + 29.576s (userspace) = 38.830s. May 14 19:17:40 musik-amp volumio[851]: info: Plugin mpdemulation is not enabled May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "rest_api"... May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "websocket"... May 14 19:17:40 musik-amp volumio[851]: info: Loading plugin "fusiondsp"... May 14 19:17:40 musik-amp volumio[851]: Forking 3 albumart workers May 14 19:17:41 musik-amp volumio-remote-updater[556]: [2024-05-14 19:17:40] [connect] Successful connection May 14 19:17:41 musik-amp volumio[851]: info: Applying required configuration parameters for plugin fusiondsp May 14 19:17:41 musik-amp volumio[851]: info: Loading plugin "Systeminfo"... May 14 19:17:41 musik-amp volumio[851]: Starting albumart workers May 14 19:17:41 musik-amp volumio[851]: Starting albumart workers May 14 19:17:41 musik-amp volumio[851]: Starting albumart workers May 14 19:17:41 musik-amp volumio[851]: info: Plugin touch_display is not enabled May 14 19:17:41 musik-amp volumio[851]: info: Loading i18n strings for locale en May 14 19:17:41 musik-amp volumio[851]: Updating browse sources language May 14 19:17:41 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::initPlayerControls May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 14 19:17:42 musik-amp volumio[851]: Express server listening on port 3000 May 14 19:17:42 musik-amp volumio[851]: [Metrics] WebUI: 5s 565.84ms May 14 19:17:42 musik-amp volumio[851]: info: CoreStateMachine::resetVolumioState May 14 19:17:42 musik-amp volumio[851]: info: CoreStateMachine::getcurrentVolume May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::volumioRetrievevolume May 14 19:17:42 musik-amp volumio[851]: verbose: New Socket.io Connection to 192.168.1.175 from 192.168.1.166 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 1 May 14 19:17:42 musik-amp volumio[851]: verbose: New Socket.io Connection to 192.168.1.175 from 192.168.1.166 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 2 May 14 19:17:42 musik-amp volumio[851]: verbose: New Socket.io Connection to 192.168.1.175:3000 from 192.168.1.176 UA: node-XMLHttpRequest Total Clients: 3 May 14 19:17:42 musik-amp volumio[851]: verbose: New Socket.io Connection to 192.168.1.175 from 192.168.1.166 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 4 May 14 19:17:42 musik-amp volumio-remote-updater[556]: [2024-05-14 19:17:42] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1715714260 101 May 14 19:17:42 musik-amp volumio[851]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 5 May 14 19:17:42 musik-amp volumio[851]: verbose: New Socket.io Connection to 192.168.1.175:3000 from 192.168.1.176 UA: node-XMLHttpRequest Total Clients: 6 May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: Executing start script for DAC IQaudIO Pi-DigiAMP+ May 14 19:17:42 musik-amp volumio[851]: info: Setting Device type: Raspberry PI May 14 19:17:42 musik-amp volumio[851]: info: CoreStateMachine::setRepeat false single undefined May 14 19:17:42 musik-amp volumio[851]: info: CoreStateMachine::pushState May 14 19:17:42 musik-amp volumio[851]: info: CorePlayQueue::getTrack 0 May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::volumioPushState May 14 19:17:42 musik-amp volumio[851]: info: CoreStateMachine::setRandom true May 14 19:17:42 musik-amp volumio[851]: info: CoreStateMachine::pushState May 14 19:17:42 musik-amp volumio[851]: info: CorePlayQueue::getTrack 0 May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::volumioPushState May 14 19:17:42 musik-amp volumio[851]: info: DAC script executed May 14 19:17:42 musik-amp volumio[851]: info: Completed loading Core Plugins May 14 19:17:42 musik-amp volumio[851]: info: Preparing to generate the ALSA configuration file May 14 19:17:42 musik-amp volumio[851]: info: VolumeController:: Volume=28 Mute =false May 14 19:17:42 musik-amp volumio[851]: info: CoreStateMachine::pushState May 14 19:17:42 musik-amp volumio[851]: info: CorePlayQueue::getTrack 0 May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::volumioPushState May 14 19:17:42 musik-amp volumio[851]: info: CoreStateMachine::updateTrackBlock May 14 19:17:42 musik-amp volumio[851]: info: CorePlayQueue::getTrackBlock May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::volumioRetrievevolume May 14 19:17:42 musik-amp volumio[851]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 14 19:17:42 musik-amp volumio[851]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 14 19:17:42 musik-amp volumio[851]: info: Reading ALSA contributions from plugins. May 14 19:17:42 musik-amp volumio[851]: info: Reloading queue from file May 14 19:17:42 musik-amp volumio[851]: info: Asound.conf file unchanged, so no further update is needed May 14 19:17:42 musik-amp volumio[851]: info: Output device has changed, restarting MPD May 14 19:17:42 musik-amp volumio[851]: info: Output device has changed, restarting Shairport Sync May 14 19:17:42 musik-amp sudo[1012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 14 19:17:42 musik-amp sudo[1012]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:42 musik-amp sudo[1012]: pam_unix(sudo:session): session closed for user root May 14 19:17:42 musik-amp sudo[1014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 14 19:17:42 musik-amp sudo[1014]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:42 musik-amp sudo[887]: pam_unix(sudo:session): session closed for user root May 14 19:17:42 musik-amp volumio[851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 14 19:17:42 musik-amp volumio[851]: info: ___________ START PLUGINS ___________ May 14 19:17:42 musik-amp volumio[851]: info: ControllerMpd::onStart: Initializing MPD May 14 19:17:42 musik-amp volumio[851]: info: Creating MPD Configuration file May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 14 19:17:42 musik-amp sudo[1022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 14 19:17:42 musik-amp sudo[1022]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 14 19:17:42 musik-amp volumio[851]: info: [1715714262727] CoreMusicLibrary::Adding element Media Servers May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:42 musik-amp systemd[1]: Listening on mpd.socket. May 14 19:17:42 musik-amp sudo[1022]: pam_unix(sudo:session): session closed for user root May 14 19:17:42 musik-amp sudo[1024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 14 19:17:42 musik-amp sudo[1024]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:42 musik-amp systemd[1]: Starting Music Player Daemon... May 14 19:17:42 musik-amp volumio[851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:42 musik-amp systemd[1]: mpd.service: Succeeded. May 14 19:17:42 musik-amp systemd[1]: Stopped Music Player Daemon. May 14 19:17:42 musik-amp systemd[1]: Starting Music Player Daemon... May 14 19:17:42 musik-amp volumio[851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 14 19:17:42 musik-amp volumio[851]: info: [1715714262829] CoreMusicLibrary::Adding element Last_100 May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 14 19:17:42 musik-amp volumio[851]: info: [1715714262833] CoreMusicLibrary::Adding element Webradio May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 14 19:17:42 musik-amp volumio[851]: info: Loading i18n strings for locale en May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:42 musik-amp volumio[851]: info: FusionDsp - mixtype--------------------- Hardware May 14 19:17:42 musik-amp volumio[851]: info: Cannot retrieve data for calling home May 14 19:17:42 musik-amp volumio[851]: info: Preparing to generate the ALSA configuration file May 14 19:17:42 musik-amp volumio[851]: info: Discovery: adding 1440923d-c621-42f1-9e39-33dbc8ff69c1 May 14 19:17:42 musik-amp volumio[851]: info: Discovery: Found device Musik amp May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::volumioGetState May 14 19:17:42 musik-amp volumio[851]: info: CorePlayQueue::getTrack 0 May 14 19:17:42 musik-amp volumio[851]: info: Discovery: adding 3d9836c3-9ad4-48a6-9fe1-d8b7df414149 May 14 19:17:42 musik-amp volumio[851]: info: Discovery: Found device Musik May 14 19:17:42 musik-amp volumio[851]: info: Discovery: Connecting to remote: 192.168.1.176 May 14 19:17:42 musik-amp volumio[851]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 14 19:17:42 musik-amp volumio[851]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 14 19:17:42 musik-amp volumio[851]: info: Reading ALSA contributions from plugins. May 14 19:17:42 musik-amp volumio[851]: info: MPD Permissions set May 14 19:17:42 musik-amp volumio[851]: info: MPD Permissions set May 14 19:17:42 musik-amp volumio[851]: info: VolumeController:: Volume=28 Mute =false May 14 19:17:42 musik-amp volumio[851]: info: CoreStateMachine::pushState May 14 19:17:42 musik-amp volumio[851]: info: CorePlayQueue::getTrack 0 May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 14 19:17:42 musik-amp volumio[851]: info: CoreCommandRouter::volumioPushState May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket May 14 19:17:43 musik-amp volumio[851]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::volumioGetState May 14 19:17:43 musik-amp volumio[851]: info: CorePlayQueue::getTrack 0 May 14 19:17:43 musik-amp volumio[851]: info: Discovery: Connected to remote: 192.168.1.176 May 14 19:17:43 musik-amp volumio[851]: info: Starting Shairport Sync May 14 19:17:43 musik-amp volumio[851]: info: Starting Shairport Sync May 14 19:17:43 musik-amp volumio[851]: info: Starting Shairport Sync May 14 19:17:43 musik-amp sudo[1044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 14 19:17:43 musik-amp sudo[1044]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:43 musik-amp sudo[1046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 14 19:17:43 musik-amp sudo[1046]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:43 musik-amp systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 14 19:17:43 musik-amp systemd[1]: shairport-sync.service: Succeeded. May 14 19:17:43 musik-amp systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 14 19:17:43 musik-amp sudo[1050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 14 19:17:43 musik-amp sudo[1050]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:43 musik-amp volumio[851]: info: Asound.conf file unchanged, so no further update is needed May 14 19:17:43 musik-amp volumio[851]: info: Output device has changed, restarting MPD May 14 19:17:43 musik-amp sudo[1044]: pam_unix(sudo:session): session closed for user root May 14 19:17:43 musik-amp systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 14 19:17:43 musik-amp volumio[851]: info: Output device has changed, restarting Shairport Sync May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:43 musik-amp systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 14 19:17:43 musik-amp sudo[1054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 14 19:17:43 musik-amp sudo[1054]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:43 musik-amp systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM May 14 19:17:43 musik-amp systemd[1]: shairport-sync.service: Succeeded. May 14 19:17:43 musik-amp systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 14 19:17:43 musik-amp systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 14 19:17:43 musik-amp sudo[1056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 14 19:17:43 musik-amp sudo[1056]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:43 musik-amp sudo[1046]: pam_unix(sudo:session): session closed for user root May 14 19:17:43 musik-amp sudo[1054]: pam_unix(sudo:session): session closed for user root May 14 19:17:43 musik-amp sudo[1050]: pam_unix(sudo:session): session closed for user root May 14 19:17:43 musik-amp systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 14 19:17:43 musik-amp systemd[1]: mpd.service: Succeeded. May 14 19:17:43 musik-amp systemd[1]: Stopped Music Player Daemon. May 14 19:17:43 musik-amp volumio[851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 14 19:17:43 musik-amp volumio[851]: info: MPD Permissions set May 14 19:17:43 musik-amp volumio[851]: info: Shairport-Sync Started May 14 19:17:43 musik-amp volumio[851]: Error adding Membership: Error: addMembership EINVAL May 14 19:17:43 musik-amp volumio[851]: info: Shairport-Sync Started May 14 19:17:43 musik-amp volumio[851]: info: Shairport-Sync Started May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::volumioGetState May 14 19:17:43 musik-amp volumio[851]: info: CorePlayQueue::getTrack 0 May 14 19:17:43 musik-amp systemd[1]: Starting Music Player Daemon... May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:43 musik-amp volumio[851]: info: Starting Shairport Sync May 14 19:17:43 musik-amp sudo[1072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 14 19:17:43 musik-amp sudo[1072]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:43 musik-amp systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 14 19:17:43 musik-amp systemd[1]: shairport-sync.service: Succeeded. May 14 19:17:43 musik-amp systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 14 19:17:43 musik-amp systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 14 19:17:43 musik-amp sudo[1072]: pam_unix(sudo:session): session closed for user root May 14 19:17:43 musik-amp volumio[851]: info: Shairport-Sync Started May 14 19:17:44 musik-amp mpd[1065]: May 14 19:17 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 14 19:17:44 musik-amp systemd[1]: Started Music Player Daemon. May 14 19:17:44 musik-amp sudo[1056]: pam_unix(sudo:session): session closed for user root May 14 19:17:44 musik-amp sudo[1024]: pam_unix(sudo:session): session closed for user root May 14 19:17:44 musik-amp sudo[1014]: pam_unix(sudo:session): session closed for user root May 14 19:17:44 musik-amp volumio[851]: info: Completed starting Core Plugins May 14 19:17:44 musik-amp volumio[851]: info: ------------------------------------------- May 14 19:17:44 musik-amp volumio[851]: info: ----- MyVolumio plugins startup ---- May 14 19:17:44 musik-amp volumio[851]: info: ------------------------------------------- May 14 19:17:44 musik-amp volumio[851]: info: [MyVolumio PluginManager] Fetching plans data.... May 14 19:17:44 musik-amp volumio[851]: info: camilladsp spawned new process with pid 1087, instance 1, run: true May 14 19:17:44 musik-amp volumio[851]: info: camilladsp service started and running in background, instance 1 May 14 19:17:44 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 19:17:44 musik-amp volumio[851]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA May 14 19:17:44 musik-amp kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 May 14 19:17:44 musik-amp volumio[851]: info: FusionDsp loaded May 14 19:17:44 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 14 19:17:44 musik-amp sudo[1091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 14 19:17:44 musik-amp sudo[1091]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:44 musik-amp volumio[851]: info: FusionDsp - Reporting Fusion DSP Enabled May 14 19:17:44 musik-amp volumio[851]: info: Adding Signal Path Element [object Object] May 14 19:17:44 musik-amp volumio[851]: info: Adding fusiondspeq DSP Signal Path Element May 14 19:17:44 musik-amp volumio[851]: info: FusionDsp - ---- installed callbackRead May 14 19:17:44 musik-amp volumio[851]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 14 19:17:45 musik-amp volumio[851]: info: MPD running with PID1065 May 14 19:17:45 musik-amp volumio[851]: ,establishing connection May 14 19:17:45 musik-amp kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 May 14 19:17:45 musik-amp systemd[1]: Started FusionDsp Daemon. May 14 19:17:45 musik-amp sudo[1091]: pam_unix(sudo:session): session closed for user root May 14 19:17:45 musik-amp volumio[851]: error: MPD error: The expression evaluated to a falsy value: May 14 19:17:45 musik-amp volumio[851]: assert.ok(self.idling) May 14 19:17:45 musik-amp volumio[851]: error: The expression evaluated to a falsy value: May 14 19:17:45 musik-amp volumio[851]: assert.ok(self.idling) May 14 19:17:45 musik-amp volumio[851]: error: MPD error: The expression evaluated to a falsy value: May 14 19:17:45 musik-amp volumio[851]: assert.ok(self.idling) May 14 19:17:45 musik-amp volumio[851]: error: The expression evaluated to a falsy value: May 14 19:17:45 musik-amp volumio[851]: assert.ok(self.idling) May 14 19:17:45 musik-amp volumio[851]: error: MPD error: The expression evaluated to a falsy value: May 14 19:17:45 musik-amp volumio[851]: assert.ok(self.idling) May 14 19:17:45 musik-amp volumio[851]: error: The expression evaluated to a falsy value: May 14 19:17:45 musik-amp volumio[851]: assert.ok(self.idling) May 14 19:17:45 musik-amp volumio[851]: error: FusionDsp - WebSocket error: [object Object] May 14 19:17:45 musik-amp volumio[851]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 May 14 19:17:45 musik-amp volumio[851]: error: updateQueue error: null May 14 19:17:46 musik-amp systemd[1]: systemd-fsckd.service: Succeeded. May 14 19:17:47 musik-amp sudo[1101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 14 19:17:47 musik-amp sudo[1101]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:47 musik-amp sudo[1101]: pam_unix(sudo:session): session closed for user root May 14 19:17:47 musik-amp sudo[1103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 14 19:17:47 musik-amp sudo[1103]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:47 musik-amp sudo[1103]: pam_unix(sudo:session): session closed for user root May 14 19:17:47 musik-amp sh[420]: timed out May 14 19:17:47 musik-amp dhcpcd[465]: timed out May 14 19:17:47 musik-amp sh[420]: dhcpcd exited May 14 19:17:47 musik-amp dhcpcd[465]: dhcpcd exited May 14 19:17:47 musik-amp sh[420]: ifup: failed to bring up eth0 May 14 19:17:47 musik-amp systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE May 14 19:17:47 musik-amp systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. May 14 19:17:47 musik-amp volumio[851]: verbose: New Socket.io Connection to 192.168.1.175 from 192.168.1.166 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 9 May 14 19:17:47 musik-amp volumio[851]: info: CoreCommandRouter::volumioGetState May 14 19:17:47 musik-amp volumio[851]: info: CorePlayQueue::getTrack 0 May 14 19:17:47 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 14 19:17:47 musik-amp volumio[851]: info: CoreCommandRouter::volumioGetVisibleSources May 14 19:17:47 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 14 19:17:47 musik-amp volumio[851]: info: Listing playlists May 14 19:17:47 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 14 19:17:47 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 14 19:17:47 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 14 19:17:47 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 14 19:17:49 musik-amp sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 14 19:17:49 musik-amp sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:49 musik-amp sudo[1108]: pam_unix(sudo:session): session closed for user root May 14 19:17:49 musik-amp sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 14 19:17:49 musik-amp sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:49 musik-amp sudo[1110]: pam_unix(sudo:session): session closed for user root May 14 19:17:49 musik-amp sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 14 19:17:49 musik-amp sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:49 musik-amp systemd[1]: Started UPnP Renderer front-end to MPD. May 14 19:17:49 musik-amp systemd[1]: systemd-hostnamed.service: Succeeded. May 14 19:17:49 musik-amp sudo[1114]: pam_unix(sudo:session): session closed for user root May 14 19:17:49 musik-amp volumio[851]: info: Upmpdcli Daemon Started May 14 19:17:49 musik-amp volumio[1116]: Generating RSA private key, 4096 bit long modulus (2 primes) May 14 19:17:50 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 14 19:17:50 musik-amp volumio[851]: info: Received Get System Info May 14 19:17:50 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 14 19:17:50 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 14 19:17:50 musik-amp volumio[851]: info: Discovery: Getting this device information May 14 19:17:50 musik-amp volumio[851]: info: CoreCommandRouter::volumioGetState May 14 19:17:50 musik-amp volumio[851]: info: CorePlayQueue::getTrack 0 May 14 19:17:50 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 14 19:17:50 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 14 19:17:50 musik-amp volumio[851]: info: Received Get System Info May 14 19:17:50 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 14 19:17:50 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 14 19:17:50 musik-amp volumio[851]: info: Discovery: Getting this device information May 14 19:17:50 musik-amp volumio[851]: info: CoreCommandRouter::volumioGetState May 14 19:17:50 musik-amp volumio[851]: info: CorePlayQueue::getTrack 0 May 14 19:17:50 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 14 19:17:51 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 14 19:17:51 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 14 19:17:53 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 14 19:17:53 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 14 19:17:53 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 14 19:17:53 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 14 19:17:53 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 14 19:17:53 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 14 19:17:54 musik-amp volumio[851]: info: Adding plugin bluetooth to MyMusic Plugins May 14 19:17:54 musik-amp volumio[851]: info: Adding plugin multiroom to MyMusic Plugins May 14 19:17:54 musik-amp volumio[851]: info: Adding plugin metavolumio to MyMusic Plugins May 14 19:17:54 musik-amp volumio[851]: info: Adding plugin cd_controller to MyMusic Plugins May 14 19:17:54 musik-amp volumio[851]: info: Adding plugin smart_inputs to MyMusic Plugins May 14 19:17:54 musik-amp volumio[851]: info: Adding plugin tidalconnect to MyMusic Plugins May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 14 19:17:54 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:54 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:54 musik-amp volumio[851]: info: Starting MyVolumio Remote Streaming Endpoints May 14 19:17:54 musik-amp volumio[851]: info: MyVolumio login type: Token May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 14 19:17:54 musik-amp volumio[851]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 14 19:17:55 musik-amp volumio[851]: info: Starting Streaming Service Transparent Proxy May 14 19:17:55 musik-amp volumio[851]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 14 19:17:55 musik-amp volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 14 19:17:55 musik-amp volumio[851]: info: Streaming services startup May 14 19:17:55 musik-amp volumio[851]: info: Starting Streaming Daemon May 14 19:17:55 musik-amp sudo[1141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 14 19:17:55 musik-amp sudo[1141]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 19:17:55 musik-amp sudo[1141]: pam_unix(sudo:session): session closed for user root May 14 19:17:55 musik-amp volumio[851]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 14 19:17:55 musik-amp volumio[851]: error: Cannot start Volumio Streaming Daemon May 14 19:17:55 musik-amp volumio[851]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 14 19:17:55 musik-amp volumio[851]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 14 19:17:56 musik-amp volumio[851]: error: MyVolumio Custom Token format not valid, refreshing it May 14 19:17:56 musik-amp volumio[851]: info: CoreCommandRouter::volumioGetQueue May 14 19:17:56 musik-amp volumio[851]: info: CoreStateMachine::getQueue May 14 19:17:56 musik-amp volumio[851]: info: CorePlayQueue::getQueue May 14 19:17:56 musik-amp volumio[851]: STREAMING PROXY: Starting server on port 3245 May 14 19:17:56 musik-amp volumio[851]: Node JS runtime: 14 May 14 19:17:57 musik-amp volumio[851]: info: MyVolumio login type: Token May 14 19:17:57 musik-amp volumio[851]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 14 19:17:58 musik-amp volumio[851]: info: MyVolumio token set successfully May 14 19:17:58 musik-amp volumio[851]: info: MYVOLUMIO: Adding device May 14 19:17:58 musik-amp volumio[851]: info: MYVOLUMIO: Evaluating Server May 14 19:17:58 musik-amp volumio[851]: info: MyVolumio Plan changed: premium May 14 19:17:58 musik-amp volumio[851]: info: [MyVolumio PluginManager] Subscribed plan changed to premium May 14 19:17:58 musik-amp volumio[851]: info: Removing browser output: myVolumio user plan is not superstar May 14 19:17:58 musik-amp volumio[851]: info: Removing audio output: May 14 19:17:58 musik-amp volumio[851]: info: MYVOLUMIO: Adding device May 14 19:17:58 musik-amp volumio[851]: info: MYVOLUMIO: Evaluating Server May 14 19:17:58 musik-amp volumio[851]: info: Remote config written successfully May 14 19:17:58 musik-amp volumio[851]: info: Starting Tunnel 1 May 14 19:17:58 musik-amp volumio[851]: info: Starting Tunnel Connection Checker May 14 19:17:58 musik-amp volumio[851]: info: Completed starting MyVolumio Plugin May 14 19:17:59 musik-amp volumio[851]: info: MYVolumio Device enabled May 14 19:17:59 musik-amp volumio[851]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... May 14 19:17:59 musik-amp volumio[851]: info: Setting Geolocation for MyVolumio to eu6 May 14 19:17:59 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:59 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:59 musik-amp volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 19:17:59 musik-amp volumio[851]: [2024-05-14T19:17:59.073Z] @firebase/database: FIREBASE WARNING: Exception was thrown by user callback. TypeError: Cannot read property 'replace' of null May 14 19:17:59 musik-amp volumio[851]: at MyVolumioPluginManager.fetchPluginKeys (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:8044) May 14 19:17:59 musik-amp volumio[851]: at MyVolumioPluginManager.loadMyVolumioPlugins (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:11563) May 14 19:17:59 musik-amp volumio[851]: at MyVolumioPluginManager.myVolumioDeviceStatusChanged (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5527) May 14 19:17:59 musik-amp volumio[851]: at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6807 May 14 19:17:59 musik-amp volumio[851]: at /volumio/node_modules/v-conf/index.js:165:13 May 14 19:17:59 musik-amp volumio[851]: at /volumio/node_modules/multimap/index.js:150:9 May 14 19:17:59 musik-amp volumio[851]: at Array.forEach () May 14 19:17:59 musik-amp volumio[851]: at /volumio/node_modules/multimap/index.js:149:13 May 14 19:17:59 musik-amp volumio[851]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) May 14 19:17:59 musik-amp volumio[851]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5) May 14 19:17:59 musik-amp volumio[851]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10) May 14 19:17:59 musik-amp volumio[851]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20) May 14 19:17:59 musik-amp volumio[851]: at myVolumio.togglePremiumPlugins (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:36225) May 14 19:17:59 musik-amp volumio[851]: at /myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:17857 May 14 19:17:59 musik-amp volumio[851]: at /volumio/node_modules/@firebase/database/dist/index.node.cjs.js:4549:22 May 14 19:17:59 musik-amp volumio[851]: at exceptionGuard (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:698:9) May 14 19:17:59 musik-amp volumio[851]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 14 19:17:59 musik-amp volumio[851]: TypeError: Cannot read property 'replace' of null May 14 19:17:59 musik-amp volumio[851]: at MyVolumioPluginManager.fetchPluginKeys (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:8044) May 14 19:17:59 musik-amp volumio[851]: at MyVolumioPluginManager.loadMyVolumioPlugins (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:11563) May 14 19:17:59 musik-amp volumio[851]: at MyVolumioPluginManager.myVolumioDeviceStatusChanged (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5527) May 14 19:17:59 musik-amp volumio[851]: at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6807 May 14 19:17:59 musik-amp volumio[851]: at /volumio/node_modules/v-conf/index.js:165:13 May 14 19:17:59 musik-amp volumio[851]: at /volumio/node_modules/multimap/index.js:150:9 May 14 19:17:59 musik-amp volumio[851]: at Array.forEach () May 14 19:17:59 musik-amp volumio[851]: at /volumio/node_modules/multimap/index.js:149:13 May 14 19:17:59 musik-amp volumio[851]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) May 14 19:17:59 musik-amp volumio[851]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5) May 14 19:17:59 musik-amp volumio[851]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10) May 14 19:17:59 musik-amp volumio[851]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20) May 14 19:17:59 musik-amp volumio[851]: at myVolumio.togglePremiumPlugins (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:36225) May 14 19:17:59 musik-amp volumio[851]: at /myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:17857 May 14 19:17:59 musik-amp volumio[851]: at /volumio/node_modules/@firebase/database/dist/index.node.cjs.js:4549:22 May 14 19:17:59 musik-amp volumio[851]: at exceptionGuard (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:698:9) May 14 19:17:59 musik-amp volumio[851]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 14 19:17:59 musik-amp volumio[1116]: .........................................................................................................++++ May 14 19:17:59 musik-amp sudo[1189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-14 19:16 May 14 19:17:59 musik-amp sudo[1189]: pam_unix(sudo:session): session opened for user root by (uid=0) 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"