-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2024-03-24 08:42:23 CET. -- Mar 24 08:41:32 volumiow kernel: usbcore: registered new interface driver lan78xx Mar 24 08:41:32 volumiow kernel: usbcore: registered new interface driver smsc95xx Mar 24 08:41:32 volumiow kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Mar 24 08:41:32 volumiow kernel: Core Release: 2.80a Mar 24 08:41:32 volumiow kernel: Setting default values for core params Mar 24 08:41:32 volumiow kernel: Finished setting default values for core params Mar 24 08:41:32 volumiow kernel: Using Buffer DMA mode Mar 24 08:41:32 volumiow kernel: Periodic Transfer Interrupt Enhancement - disabled Mar 24 08:41:32 volumiow kernel: Multiprocessor Interrupt Enhancement - disabled Mar 24 08:41:32 volumiow kernel: OTG VER PARAM: 0, OTG VER FLAG: 0 Mar 24 08:41:32 volumiow kernel: Dedicated Tx FIFOs mode Mar 24 08:41:32 volumiow kernel: Mar 24 08:41:32 volumiow kernel: WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = b4104000 dma = 0xf4104000 len=9024 Mar 24 08:41:32 volumiow kernel: FIQ FSM acceleration enabled for : Non-periodic Split Transactions Periodic Split Transactions High-Speed Isochronous Endpoints Interrupt/Control Split Transaction hack enabled Mar 24 08:41:32 volumiow kernel: dwc_otg: Microframe scheduler enabled Mar 24 08:41:32 volumiow kernel: Mar 24 08:41:32 volumiow kernel: WARN::hcd_init_fiq:457: FIQ on core 1 Mar 24 08:41:32 volumiow kernel: Mar 24 08:41:32 volumiow kernel: WARN::hcd_init_fiq:458: FIQ ASM at 807cb80c length 36 Mar 24 08:41:32 volumiow kernel: Mar 24 08:41:32 volumiow kernel: WARN::hcd_init_fiq:497: MPHI regs_base at b8810000 Mar 24 08:41:32 volumiow kernel: dwc_otg 3f980000.usb: DWC OTG Controller Mar 24 08:41:32 volumiow kernel: dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1 Mar 24 08:41:32 volumiow kernel: dwc_otg 3f980000.usb: irq 89, io mem 0x00000000 Mar 24 08:41:32 volumiow kernel: Init: Port Power? op_state=1 Mar 24 08:41:32 volumiow kernel: Init: Power Port (0) Mar 24 08:41:32 volumiow kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01 Mar 24 08:41:32 volumiow kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 24 08:41:32 volumiow kernel: usb usb1: Product: DWC OTG Controller Mar 24 08:41:32 volumiow kernel: usb usb1: Manufacturer: Linux 6.1.69-v7+ dwc_otg_hcd Mar 24 08:41:32 volumiow kernel: usb usb1: SerialNumber: 3f980000.usb Mar 24 08:41:32 volumiow kernel: hub 1-0:1.0: USB hub found Mar 24 08:41:32 volumiow kernel: hub 1-0:1.0: 1 port detected Mar 24 08:41:32 volumiow kernel: dwc_otg: FIQ enabled Mar 24 08:41:32 volumiow kernel: dwc_otg: NAK holdoff enabled Mar 24 08:41:32 volumiow kernel: dwc_otg: FIQ split-transaction FSM enabled Mar 24 08:41:32 volumiow kernel: Module dwc_common_port init Mar 24 08:41:32 volumiow kernel: usbcore: registered new interface driver usb-storage Mar 24 08:41:32 volumiow kernel: mousedev: PS/2 mouse device common for all mice Mar 24 08:41:32 volumiow kernel: sdhci: Secure Digital Host Controller Interface driver Mar 24 08:41:32 volumiow kernel: sdhci: Copyright(c) Pierre Ossman Mar 24 08:41:32 volumiow kernel: sdhci-pltfm: SDHCI platform and OF driver helper Mar 24 08:41:32 volumiow kernel: ledtrig-cpu: registered to indicate activity on CPUs Mar 24 08:41:32 volumiow kernel: hid: raw HID events driver (C) Jiri Kosina Mar 24 08:41:32 volumiow kernel: usbcore: registered new interface driver usbhid Mar 24 08:41:32 volumiow kernel: usbhid: USB HID core driver Mar 24 08:41:32 volumiow kernel: Initializing XFRM netlink socket Mar 24 08:41:32 volumiow kernel: NET: Registered PF_PACKET protocol family Mar 24 08:41:32 volumiow kernel: Key type dns_resolver registered Mar 24 08:41:32 volumiow kernel: Registering SWP/SWPB emulation handler Mar 24 08:41:32 volumiow kernel: registered taskstats version 1 Mar 24 08:41:32 volumiow kernel: Loading compiled-in X.509 certificates Mar 24 08:41:32 volumiow kernel: Key type .fscrypt registered Mar 24 08:41:32 volumiow kernel: Key type fscrypt-provisioning registered Mar 24 08:41:32 volumiow kernel: uart-pl011 3f201000.serial: cts_event_workaround enabled Mar 24 08:41:32 volumiow kernel: 3f201000.serial: ttyAMA1 at MMIO 0x3f201000 (irq = 114, base_baud = 0) is a PL011 rev2 Mar 24 08:41:32 volumiow kernel: serial serial0: tty port ttyAMA1 registered Mar 24 08:41:32 volumiow kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Mar 24 08:41:32 volumiow kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Mar 24 08:41:32 volumiow kernel: mmc-bcm2835 3f300000.mmcnr: mmc_debug:0 mmc_debug2:0 Mar 24 08:41:32 volumiow kernel: mmc-bcm2835 3f300000.mmcnr: DMA channel allocated Mar 24 08:41:32 volumiow kernel: sdhost: log_buf @ 7d75941c (f4107000) Mar 24 08:41:32 volumiow kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) Mar 24 08:41:32 volumiow kernel: of_cfs_init Mar 24 08:41:32 volumiow kernel: of_cfs_init: OK Mar 24 08:41:32 volumiow kernel: Freeing unused kernel image (initmem) memory: 1024K Mar 24 08:41:32 volumiow kernel: Indeed it is in host mode hprt0 = 00021501 Mar 24 08:41:32 volumiow kernel: mmc0: host does not support reading read-only switch, assuming write-enable Mar 24 08:41:32 volumiow kernel: mmc0: new high speed SDHC card at address 0001 Mar 24 08:41:32 volumiow kernel: mmcblk0: mmc0:0001 00000 29.2 GiB Mar 24 08:41:32 volumiow kernel: mmcblk0: p1 p2 p3 Mar 24 08:41:32 volumiow kernel: mmcblk0: mmc0:0001 00000 29.2 GiB Mar 24 08:41:32 volumiow kernel: mmc1: new high speed SDIO card at address 0001 Mar 24 08:41:32 volumiow kernel: Run /init as init process Mar 24 08:41:32 volumiow kernel: with arguments: Mar 24 08:41:32 volumiow kernel: /init Mar 24 08:41:32 volumiow kernel: splash Mar 24 08:41:32 volumiow kernel: with environment: Mar 24 08:41:32 volumiow kernel: HOME=/ Mar 24 08:41:32 volumiow kernel: TERM=linux Mar 24 08:41:32 volumiow kernel: imgpart=/dev/mmcblk0p2 Mar 24 08:41:32 volumiow kernel: imgfile=/volumio_current.sqsh Mar 24 08:41:32 volumiow kernel: bootdelay=5 Mar 24 08:41:32 volumiow kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg Mar 24 08:41:32 volumiow kernel: Indeed it is in host mode hprt0 = 00001101 Mar 24 08:41:32 volumiow initramfs: Booting Volumio for BCM2835 Mar 24 08:41:32 volumiow initramfs: This script mounts rootfs RO with an overlay RW layer. Mar 24 08:41:32 volumiow kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 24 08:41:32 volumiow initramfs: IMGPART=/dev/mmcblk0p2 Mar 24 08:41:32 volumiow initramfs: IMGFILE=/volumio_current.sqsh Mar 24 08:41:32 volumiow initramfs: Boot delay (except first time) will be 5 seconds Mar 24 08:41:32 volumiow kernel: usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcdDevice= 2.00 Mar 24 08:41:32 volumiow kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Mar 24 08:41:32 volumiow kernel: hub 1-1:1.0: USB hub found Mar 24 08:41:32 volumiow kernel: hub 1-1:1.0: 5 ports detected Mar 24 08:41:32 volumiow initramfs: /dev/mmcblk0p2: Mar 24 08:41:32 volumiow kernel: EXT4-fs (mmcblk0p2): recovery complete Mar 24 08:41:32 volumiow kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. Mar 24 08:41:32 volumiow initramfs: Doing a 5 second delay here to give kernel load a headstart Mar 24 08:41:32 volumiow kernel: usb 1-1.1: new high-speed USB device number 3 using dwc_otg Mar 24 08:41:32 volumiow kernel: usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, bcdDevice= 2.00 Mar 24 08:41:32 volumiow kernel: usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Mar 24 08:41:32 volumiow kernel: smsc95xx v2.0.0 Mar 24 08:41:32 volumiow kernel: SMSC LAN8700 usb-001:003:01: attached PHY driver (mii_bus:phy_addr=usb-001:003:01, irq=199) Mar 24 08:41:32 volumiow kernel: smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:81:20:c2 Mar 24 08:41:32 volumiow initramfs: Checking for USB updates Mar 24 08:41:32 volumiow initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Mar 24 08:41:32 volumiow kernel: loop0: detected capacity change from 0 to 967536 Mar 24 08:41:32 volumiow kernel: EXT4-fs (mmcblk0p3): recovery complete Mar 24 08:41:32 volumiow kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. Mar 24 08:41:32 volumiow initramfs: With Option: Mar 24 08:41:32 volumiow initramfs: VOLUMIO_VERSION="3.631" Mar 24 08:41:32 volumiow initramfs: Finish initramfs, continue booting Volumio Mar 24 08:41:32 volumiow systemd[1]: System time before build time, advancing clock. Mar 24 08:41:32 volumiow kernel: NET: Registered PF_INET6 protocol family Mar 24 08:41:32 volumiow kernel: Segment Routing with IPv6 Mar 24 08:41:32 volumiow kernel: In-situ OAM (IOAM) with IPv6 Mar 24 08:41:32 volumiow 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) Mar 24 08:41:32 volumiow systemd[1]: Detected architecture arm. Mar 24 08:41:32 volumiow systemd[1]: Set hostname to . Mar 24 08:41:32 volumiow 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. Mar 24 08:41:32 volumiow systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Mar 24 08:41:32 volumiow systemd[1]: Listening on fsck to fsckd communication Socket. Mar 24 08:41:32 volumiow systemd[1]: Listening on udev Kernel Socket. Mar 24 08:41:32 volumiow systemd[1]: Created slice User and Session Slice. Mar 24 08:41:32 volumiow systemd[1]: Listening on Journal Socket. Mar 24 08:41:32 volumiow systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped. Mar 24 08:41:32 volumiow kernel: i2c_dev: i2c /dev entries driver Mar 24 08:41:32 volumiow systemd-journald[203]: Journal started Mar 24 08:41:32 volumiow systemd-journald[203]: Runtime journal (/run/log/journal/f19fe563bf7dcaf9ed2201976245a35f) is 7.5M, max 30.0M, 22.5M free. Mar 24 08:41:32 volumiow systemd-modules-load[188]: Inserted module 'i2c_dev' Mar 24 08:41:32 volumiow fake-hwclock[189]: Sun Mar 24 07:41:32 UTC 2024 Mar 24 08:41:32 volumiow systemd[1]: Started Load/Save Random Seed. Mar 24 08:41:32 volumiow systemd[1]: dynamicswap.service: Succeeded. Mar 24 08:41:32 volumiow systemd[1]: Started Create System Users. Mar 24 08:41:32 volumiow systemd[1]: Starting Create Static Device Nodes in /dev... Mar 24 08:41:32 volumiow systemd[1]: Started udev Coldplug all Devices. Mar 24 08:41:32 volumiow systemd[1]: Starting Helper to synchronize boot up for ifupdown... Mar 24 08:41:32 volumiow systemd[1]: Started Create Static Device Nodes in /dev. Mar 24 08:41:32 volumiow systemd[1]: Reached target Local File Systems (Pre). Mar 24 08:41:32 volumiow systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Mar 24 08:41:32 volumiow systemd[1]: Mounting /var/log... Mar 24 08:41:32 volumiow systemd[1]: Mounting /var/spool/cups... Mar 24 08:41:32 volumiow systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Mar 24 08:41:32 volumiow systemd[1]: Mounting /tmp... Mar 24 08:41:32 volumiow systemd[1]: Starting udev Kernel Device Manager... Mar 24 08:41:32 volumiow systemd[1]: Mounted /var/log. Mar 24 08:41:32 volumiow systemd[1]: Mounted /var/spool/cups. Mar 24 08:41:32 volumiow systemd[1]: Mounted /tmp. Mar 24 08:41:32 volumiow systemd[1]: Mounting /var/spool/cups/tmp... Mar 24 08:41:32 volumiow systemd[1]: Starting Flush Journal to Persistent Storage... Mar 24 08:41:32 volumiow systemd[1]: Mounted /var/spool/cups/tmp. Mar 24 08:41:32 volumiow systemd-udevd[230]: Network interface NamePolicy= disabled on kernel command line, ignoring. Mar 24 08:41:32 volumiow systemd-journald[203]: Runtime journal (/run/log/journal/f19fe563bf7dcaf9ed2201976245a35f) is 7.5M, max 30.0M, 22.5M free. Mar 24 08:41:32 volumiow systemd[1]: Started Flush Journal to Persistent Storage. Mar 24 08:41:32 volumiow systemd[1]: Started udev Kernel Device Manager. Mar 24 08:41:32 volumiow systemd[1]: Starting Show Plymouth Boot Screen... Mar 24 08:41:32 volumiow systemd[1]: Received SIGRTMIN+20 from PID 247 (plymouthd). Mar 24 08:41:32 volumiow systemd[1]: Started Show Plymouth Boot Screen. Mar 24 08:41:32 volumiow systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 24 08:41:32 volumiow systemd[1]: Reached target Paths. Mar 24 08:41:32 volumiow systemd[1]: Reached target Local Encrypted Volumes. Mar 24 08:41:32 volumiow systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Mar 24 08:41:32 volumiow kernel: rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 Mar 24 08:41:32 volumiow kernel: rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem Mar 24 08:41:32 volumiow kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Mar 24 08:41:32 volumiow kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Mar 24 08:41:32 volumiow kernel: [vc_sm_connected_init]: start Mar 24 08:41:32 volumiow kernel: mc: Linux media interface: v0.10 Mar 24 08:41:32 volumiow kernel: [vc_sm_connected_init]: installed successfully Mar 24 08:41:33 volumiow kernel: videodev: Linux video capture interface: v2.00 Mar 24 08:41:33 volumiow kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Mar 24 08:41:33 volumiow kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Mar 24 08:41:33 volumiow kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Mar 24 08:41:33 volumiow kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Mar 24 08:41:33 volumiow kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Mar 24 08:41:33 volumiow kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Mar 24 08:41:33 volumiow kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Mar 24 08:41:33 volumiow kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Mar 24 08:41:33 volumiow kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Mar 24 08:41:33 volumiow kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Mar 24 08:41:33 volumiow kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Mar 24 08:41:33 volumiow kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Mar 24 08:41:33 volumiow kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Mar 24 08:41:33 volumiow kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Mar 24 08:41:33 volumiow kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Mar 24 08:41:33 volumiow kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Mar 24 08:41:33 volumiow kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Mar 24 08:41:33 volumiow kernel: Bluetooth: Core ver 2.22 Mar 24 08:41:33 volumiow kernel: NET: Registered PF_BLUETOOTH protocol family Mar 24 08:41:33 volumiow kernel: Bluetooth: HCI device and connection manager initialized Mar 24 08:41:33 volumiow kernel: Bluetooth: HCI socket layer initialized Mar 24 08:41:33 volumiow kernel: Bluetooth: L2CAP socket layer initialized Mar 24 08:41:33 volumiow kernel: Bluetooth: SCO socket layer initialized Mar 24 08:41:33 volumiow kernel: Bluetooth: HCI UART driver ver 2.3 Mar 24 08:41:33 volumiow kernel: Bluetooth: HCI UART protocol H4 registered Mar 24 08:41:33 volumiow kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Mar 24 08:41:33 volumiow kernel: Bluetooth: HCI UART protocol Broadcom registered Mar 24 08:41:33 volumiow kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Mar 24 08:41:33 volumiow kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Mar 24 08:41:33 volumiow kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Mar 24 08:41:33 volumiow kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Mar 24 08:41:33 volumiow systemd-udevd[238]: Using default interface naming scheme 'v240'. Mar 24 08:41:33 volumiow kernel: uart-pl011 3f201000.serial: no DMA platform data Mar 24 08:41:33 volumiow kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Mar 24 08:41:34 volumiow kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Mar 24 08:41:34 volumiow kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Mar 24 08:41:34 volumiow systemd-udevd[238]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 24 08:41:34 volumiow kernel: Bluetooth: hci0: BCM: chip id 94 Mar 24 08:41:34 volumiow kernel: Bluetooth: hci0: BCM: features 0x2e Mar 24 08:41:34 volumiow kernel: Bluetooth: hci0: BCM43430A1 Mar 24 08:41:34 volumiow kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0000 Mar 24 08:41:34 volumiow kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Mar 24 08:41:34 volumiow kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Mar 24 08:41:34 volumiow kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Mar 24 08:41:34 volumiow kernel: Bluetooth: hci0: BCM43430A1 'brcm/BCM43430A1.hcd' Patch Mar 24 08:41:34 volumiow systemd-udevd[242]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 24 08:41:34 volumiow kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6 Mar 24 08:41:34 volumiow kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 Mar 24 08:41:34 volumiow kernel: usbcore: registered new interface driver brcmfmac Mar 24 08:41:34 volumiow systemd[1]: Found device /dev/mmcblk0p1. Mar 24 08:41:34 volumiow kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Jul 19 2021 03:24:18 version 7.45.98 (TOB) (56df937 CY) FWID 01-8e14b897 Mar 24 08:41:34 volumiow systemd-udevd[243]: Using default interface naming scheme 'v240'. Mar 24 08:41:34 volumiow systemd-udevd[243]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 24 08:41:35 volumiow kernel: wm8804 1-003b: revision E Mar 24 08:41:35 volumiow kernel: Bluetooth: hci0: BCM: features 0x2e Mar 24 08:41:35 volumiow kernel: Bluetooth: hci0: BCM43438A1 37.4MHz Raspberry Pi 3-0141 Mar 24 08:41:35 volumiow kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0508 Mar 24 08:41:35 volumiow kernel: hwmon hwmon1: Undervoltage detected! Mar 24 08:41:36 volumiow systemd[1]: Started Helper to synchronize boot up for ifupdown. Mar 24 08:41:36 volumiow systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. Mar 24 08:41:36 volumiow systemd[1]: Condition check resulted in SMSC9512/9514 Fast Ethernet Adapter being skipped. Mar 24 08:41:36 volumiow systemd[1]: Created slice system-bthelper.slice. Mar 24 08:41:36 volumiow systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Mar 24 08:41:36 volumiow systemd[1]: Condition check resulted in FUSE Control File System being skipped. Mar 24 08:41:36 volumiow systemd[1]: Condition check resulted in Huge Pages File System being skipped. Mar 24 08:41:36 volumiow systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Mar 24 08:41:36 volumiow systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 24 08:41:36 volumiow systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Mar 24 08:41:36 volumiow systemd[1]: Starting File System Check on /dev/mmcblk0p1... Mar 24 08:41:36 volumiow systemd[1]: Starting Load/Save RF Kill Switch Status... Mar 24 08:41:36 volumiow systemd[1]: Started File System Check Daemon to report status. Mar 24 08:41:36 volumiow systemd[1]: Started Load/Save RF Kill Switch Status. Mar 24 08:41:36 volumiow systemd-fsck[410]: fsck.fat 4.1 (2017-01-24) Mar 24 08:41:36 volumiow systemd-fsck[410]: /dev/mmcblk0p1: 373 files, 33360/46774 clusters Mar 24 08:41:36 volumiow systemd[1]: Started File System Check on /dev/mmcblk0p1. Mar 24 08:41:36 volumiow systemd[1]: Mounting /boot... Mar 24 08:41:36 volumiow systemd[1]: Mounted /boot. Mar 24 08:41:36 volumiow systemd[1]: Reached target Local File Systems. Mar 24 08:41:36 volumiow systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Mar 24 08:41:36 volumiow systemd[1]: Starting Raise network interfaces... Mar 24 08:41:36 volumiow systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Mar 24 08:41:36 volumiow systemd[1]: Starting Create Volatile Files and Directories... Mar 24 08:41:36 volumiow systemd[1]: Started ifup for eth0. Mar 24 08:41:36 volumiow systemd[1]: Starting Preprocess NFS configuration... Mar 24 08:41:36 volumiow systemd[1]: Started ifup for wlan0. Mar 24 08:41:36 volumiow systemd[1]: plymouth-read-write.service: Succeeded. Mar 24 08:41:36 volumiow systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Mar 24 08:41:36 volumiow systemd[1]: Received SIGRTMIN+20 from PID 247 (plymouthd). Mar 24 08:41:36 volumiow systemd[1]: nfs-config.service: Succeeded. Mar 24 08:41:36 volumiow systemd[1]: Started Preprocess NFS configuration. Mar 24 08:41:36 volumiow systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Mar 24 08:41:36 volumiow systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Mar 24 08:41:36 volumiow systemd[1]: Reached target NFS client services. Mar 24 08:41:37 volumiow systemd[1]: Started Create Volatile Files and Directories. Mar 24 08:41:37 volumiow systemd[1]: Starting Update UTMP about System Boot/Shutdown... Mar 24 08:41:37 volumiow systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Mar 24 08:41:37 volumiow systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Mar 24 08:41:37 volumiow systemd[1]: Starting RPC bind portmap service... Mar 24 08:41:37 volumiow kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 24 08:41:37 volumiow systemd[1]: Started Update UTMP about System Boot/Shutdown. Mar 24 08:41:37 volumiow systemd[1]: Reached target System Initialization. Mar 24 08:41:37 volumiow kernel: 8021q: 802.1Q VLAN Support v1.8 Mar 24 08:41:37 volumiow systemd[1]: Started Volumio Splash. Mar 24 08:41:37 volumiow systemd[491]: volumiosplash.service: Failed to execute command: No such file or directory Mar 24 08:41:37 volumiow systemd[491]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory Mar 24 08:41:37 volumiow systemd[1]: Listening on D-Bus System Message Bus Socket. Mar 24 08:41:37 volumiow systemd[1]: Started Daily apt download activities. Mar 24 08:41:37 volumiow systemd[1]: Started Daily apt upgrade and clean activities. Mar 24 08:41:37 volumiow systemd[1]: Started Daily Cleanup of Temporary Directories. Mar 24 08:41:37 volumiow systemd[1]: Reached target Timers. Mar 24 08:41:37 volumiow systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Mar 24 08:41:37 volumiow systemd[1]: Listening on triggerhappy.socket. Mar 24 08:41:37 volumiow systemd[1]: Reached target Sockets. Mar 24 08:41:37 volumiow systemd[1]: Reached target Basic System. Mar 24 08:41:37 volumiow systemd[1]: Started Manage Sound Card State (restore and store). Mar 24 08:41:37 volumiow systemd[1]: Started Volumio Log Rotation Service. Mar 24 08:41:37 volumiow systemd[1]: Started D-Bus System Message Bus. Mar 24 08:41:37 volumiow alsactl[508]: alsactl 1.1.8 daemon started Mar 24 08:41:37 volumiow systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Mar 24 08:41:37 volumiow systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Mar 24 08:41:37 volumiow systemd[1]: Starting WPA supplicant... Mar 24 08:41:37 volumiow systemd[1]: Started volumio-remote-updater.service. Mar 24 08:41:37 volumiow systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Mar 24 08:41:37 volumiow systemd[1]: Starting dhcpcd on all interfaces... Mar 24 08:41:37 volumiow systemd[1]: Started UPnP Renderer front-end to MPD. Mar 24 08:41:37 volumiow systemd[1]: Starting Save/Restore Sound Card State... Mar 24 08:41:37 volumiow systemd[1]: Started Volumio Iptables Module. Mar 24 08:41:37 volumiow dhcpcd[518]: Not running dhcpcd because /etc/network/interfaces Mar 24 08:41:37 volumiow dhcpcd[518]: defines some interfaces that will use a Mar 24 08:41:37 volumiow dhcpcd[518]: DHCP client or static address Mar 24 08:41:37 volumiow systemd[1]: Starting triggerhappy global hotkey daemon... Mar 24 08:41:37 volumiow systemd[1]: Starting Configure Bluetooth Modems connected by UART... Mar 24 08:41:37 volumiow systemd[1]: Starting Wireless Services... Mar 24 08:41:37 volumiow systemd[1]: Starting Login Service... Mar 24 08:41:37 volumiow systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Mar 24 08:41:37 volumiow systemd[1]: Started RPC bind portmap service. Mar 24 08:41:37 volumiow systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC Mar 24 08:41:37 volumiow systemd[1]: volumiosplash.service: Failed with result 'exit-code'. Mar 24 08:41:37 volumiow systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Mar 24 08:41:37 volumiow systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Mar 24 08:41:37 volumiow systemd[1]: Failed to start dhcpcd on all interfaces. Mar 24 08:41:37 volumiow thd[528]: Unable to parse trigger line: Mar 24 08:41:37 volumiow thd[528]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Mar 24 08:41:37 volumiow thd[528]: Unable to parse trigger line: Mar 24 08:41:37 volumiow thd[528]: Found socket passed from systemd Mar 24 08:41:37 volumiow systemd[1]: Started triggerhappy global hotkey daemon. Mar 24 08:41:37 volumiow systemd[1]: Started Save/Restore Sound Card State. Mar 24 08:41:37 volumiow systemd[1]: Reached target Sound Card. Mar 24 08:41:37 volumiow systemd[1]: Reached target RPC Port Mapper. Mar 24 08:41:37 volumiow systemd[1]: Reached target Remote File Systems (Pre). Mar 24 08:41:37 volumiow systemd[1]: Reached target Remote File Systems. Mar 24 08:41:37 volumiow systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Mar 24 08:41:38 volumiow ifup[417]: ifup: waiting for lock on /run/network/ifstate.wlan0 Mar 24 08:41:38 volumiow systemd-logind[535]: New seat seat0. Mar 24 08:41:38 volumiow sh[422]: eth0: waiting for carrier Mar 24 08:41:38 volumiow dhcpcd[467]: eth0: waiting for carrier Mar 24 08:41:38 volumiow kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Mar 24 08:41:38 volumiow kernel: smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control off Mar 24 08:41:38 volumiow sh[422]: eth0: carrier acquired Mar 24 08:41:38 volumiow dhcpcd[467]: eth0: carrier acquired Mar 24 08:41:38 volumiow sh[424]: wlan0=wlan0 Mar 24 08:41:38 volumiow dhcpcd[467]: DUID 00:01:00:01:29:d8:62:dc:e4:5f:01:76:13:84 Mar 24 08:41:38 volumiow sh[422]: DUID 00:01:00:01:29:d8:62:dc:e4:5f:01:76:13:84 Mar 24 08:41:38 volumiow sh[422]: eth0: IAID eb:81:20:c2 Mar 24 08:41:38 volumiow sh[422]: eth0: adding address fe80::ba27:ebff:fe81:20c2 Mar 24 08:41:38 volumiow sh[422]: ipv6_addaddr1: Permission denied Mar 24 08:41:38 volumiow dhcpcd[467]: eth0: IAID eb:81:20:c2 Mar 24 08:41:38 volumiow dhcpcd[467]: eth0: adding address fe80::ba27:ebff:fe81:20c2 Mar 24 08:41:38 volumiow dhcpcd[467]: ipv6_addaddr1: Permission denied Mar 24 08:41:38 volumiow avahi-daemon[536]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Mar 24 08:41:38 volumiow avahi-daemon[536]: Successfully dropped root privileges. Mar 24 08:41:38 volumiow avahi-daemon[536]: avahi-daemon 0.7 starting up. Mar 24 08:41:38 volumiow sh[422]: eth0: soliciting a DHCP lease Mar 24 08:41:38 volumiow dhcpcd[467]: eth0: soliciting a DHCP lease Mar 24 08:41:38 volumiow systemd[1]: Started Login Service. Mar 24 08:41:38 volumiow wpa_supplicant[516]: Successfully initialized wpa_supplicant Mar 24 08:41:38 volumiow systemd[1]: hciuart.service: Succeeded. Mar 24 08:41:38 volumiow systemd[1]: Started Configure Bluetooth Modems connected by UART. Mar 24 08:41:38 volumiow sh[422]: eth0: soliciting an IPv6 router Mar 24 08:41:38 volumiow dhcpcd[467]: eth0: soliciting an IPv6 router Mar 24 08:41:38 volumiow sh[422]: eth0: offered 192.168.0.168 from 192.168.0.1 Mar 24 08:41:38 volumiow dhcpcd[467]: eth0: offered 192.168.0.168 from 192.168.0.1 Mar 24 08:41:38 volumiow avahi-daemon[536]: Successfully called chroot(). Mar 24 08:41:38 volumiow avahi-daemon[536]: Successfully dropped remaining capabilities. Mar 24 08:41:38 volumiow sh[422]: eth0: probing address 192.168.0.168/24 Mar 24 08:41:38 volumiow dhcpcd[467]: eth0: probing address 192.168.0.168/24 Mar 24 08:41:38 volumiow avahi-daemon[536]: Loading service file /services/volumio.service. Mar 24 08:41:38 volumiow avahi-daemon[536]: Network interface enumeration completed. Mar 24 08:41:38 volumiow avahi-daemon[536]: Server startup complete. Host name is volumiow.local. Local service cookie is 4194761198. Mar 24 08:41:38 volumiow avahi-daemon[536]: Service "VolumioW" (/services/volumio.service) successfully established. Mar 24 08:41:39 volumiow systemd[1]: Started Raise network interfaces. Mar 24 08:41:39 volumiow systemd[1]: Started WPA supplicant. Mar 24 08:41:39 volumiow systemd[1]: Started Avahi mDNS/DNS-SD Stack. Mar 24 08:41:39 volumiow systemd[1]: Reached target Network. Mar 24 08:41:39 volumiow systemd[1]: Reached target Network is Online. Mar 24 08:41:39 volumiow volumio-remote-updater[517]: Error: No active session Mar 24 08:41:39 volumiow volumio-remote-updater[517]: [2024-03-24 08:41:39] [info] asio async_connect error: system:111 (Connection refused) Mar 24 08:41:39 volumiow volumio-remote-updater[517]: [2024-03-24 08:41:39] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 24 08:41:39 volumiow volumio-remote-updater[517]: [2024-03-24 08:41:39] [error] handle_connect error: Underlying Transport Error Mar 24 08:41:39 volumiow systemd[1]: Starting LSB: Brings up/down network automatically... Mar 24 08:41:39 volumiow systemd[1]: Starting Network Time Service... Mar 24 08:41:39 volumiow systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Mar 24 08:41:39 volumiow systemd[1]: Starting Samba NMB Daemon... Mar 24 08:41:39 volumiow systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 24 08:41:39 volumiow volumio[522]: Could not open config: /tmp/upmpdcli.conf Mar 24 08:41:39 volumiow systemd[1]: Starting Permit User Sessions... Mar 24 08:41:39 volumiow systemd[1]: Starting /etc/rc.local Compatibility... Mar 24 08:41:39 volumiow systemd[1]: Starting Raspberry Pi bluetooth helper... Mar 24 08:41:39 volumiow systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 24 08:41:39 volumiow systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 24 08:41:39 volumiow systemd[1]: Started /etc/rc.local Compatibility. Mar 24 08:41:39 volumiow systemd[1]: iptables.service: Succeeded. Mar 24 08:41:39 volumiow systemd[1]: Started Permit User Sessions. Mar 24 08:41:39 volumiow systemd[1]: Starting Terminate Plymouth Boot Screen... Mar 24 08:41:39 volumiow systemd[1]: Starting Hold until boot process finishes up... Mar 24 08:41:39 volumiow systemd[1]: plymouth-start.service: Succeeded. Mar 24 08:41:39 volumiow loadcpufreq[558]: Loading cpufreq kernel modules...done (none). Mar 24 08:41:39 volumiow systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Mar 24 08:41:39 volumiow systemd[1]: plymouth-quit.service: Succeeded. Mar 24 08:41:39 volumiow systemd[1]: Started Terminate Plymouth Boot Screen. Mar 24 08:41:39 volumiow systemd[1]: plymouth-quit-wait.service: Succeeded. Mar 24 08:41:39 volumiow systemd[1]: Started Hold until boot process finishes up. Mar 24 08:41:39 volumiow systemd[1]: Received SIGRTMIN+21 from PID 247 (n/a). Mar 24 08:41:39 volumiow systemd[1]: Received SIGRTMIN+21 from PID 247 (n/a). Mar 24 08:41:39 volumiow bthelper[633]: Raspberry Pi BDADDR already set Mar 24 08:41:39 volumiow systemd[1]: Started Getty on tty1. Mar 24 08:41:39 volumiow systemd[1]: Reached target Login Prompts. Mar 24 08:41:39 volumiow ifplugd(eth0)[679]: ifplugd 0.28 initializing. Mar 24 08:41:39 volumiow ifplugd(eth0)[679]: Using interface eth0/B8:27:EB:81:20:C2 with driver (version: 6.1.69-v7+) Mar 24 08:41:39 volumiow ifplugd(eth0)[679]: Using detection mode: SIOCETHTOOL Mar 24 08:41:39 volumiow ifplugd(eth0)[679]: Initialization complete, link beat detected. Mar 24 08:41:39 volumiow systemd[1]: Starting LSB: set CPUFreq kernel parameters... Mar 24 08:41:39 volumiow ntpd[622]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 24 08:41:39 volumiow ntpd[622]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Mar 24 08:41:39 volumiow systemd[1]: Started Raspberry Pi bluetooth helper. Mar 24 08:41:39 volumiow systemd[1]: Started Network Time Service. Mar 24 08:41:39 volumiow systemd[1]: Starting Bluetooth service... Mar 24 08:41:39 volumiow ntpd[681]: proto: precision = 1.458 usec (-19) Mar 24 08:41:39 volumiow ifplugd(eth0)[679]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Mar 24 08:41:39 volumiow ntpd[681]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 24 08:41:39 volumiow ntpd[681]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 24 08:41:40 volumiow ntpd[681]: Listen and drop on 0 v6wildcard [::]:123 Mar 24 08:41:40 volumiow ntpd[681]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 24 08:41:40 volumiow ntpd[681]: Listen normally on 2 lo 127.0.0.1:123 Mar 24 08:41:40 volumiow ntpd[681]: Listening on routing socket on fd #19 for interface updates Mar 24 08:41:40 volumiow ntpd[681]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 24 08:41:40 volumiow ntpd[681]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 24 08:41:40 volumiow ifplugd(eth0)[679]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Mar 24 08:41:40 volumiow bluetoothd[683]: Bluetooth daemon 5.50 Mar 24 08:41:40 volumiow cpufrequtils[680]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Mar 24 08:41:40 volumiow systemd[1]: Started LSB: set CPUFreq kernel parameters. Mar 24 08:41:40 volumiow bluetoothd[683]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Mar 24 08:41:40 volumiow systemd[1]: Started Bluetooth service. Mar 24 08:41:40 volumiow systemd[1]: Reached target Bluetooth. Mar 24 08:41:40 volumiow bluetoothd[683]: Starting SDP server Mar 24 08:41:40 volumiow bluetoothd[683]: Excluding (cli) sap Mar 24 08:41:40 volumiow kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Mar 24 08:41:40 volumiow kernel: Bluetooth: BNEP filters: protocol multicast Mar 24 08:41:40 volumiow kernel: Bluetooth: BNEP socket layer initialized Mar 24 08:41:40 volumiow bluetoothd[683]: Bluetooth management interface 1.22 initialized Mar 24 08:41:40 volumiow kernel: Bluetooth: MGMT ver 1.22 Mar 24 08:41:40 volumiow dbus-daemon[510]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=683 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Mar 24 08:41:40 volumiow haveged[479]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Mar 24 08:41:40 volumiow haveged[479]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Mar 24 08:41:40 volumiow haveged[479]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99927 Mar 24 08:41:40 volumiow haveged[479]: haveged: fills: 0, generated: 0 Mar 24 08:41:40 volumiow bluetoothd[683]: Failed to set privacy: Rejected (0x0b) Mar 24 08:41:40 volumiow systemd[1]: Starting Hostname Service... Mar 24 08:41:40 volumiow ntpd[681]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 24 08:41:41 volumiow dbus-daemon[510]: [system] Successfully activated service 'org.freedesktop.hostname1' Mar 24 08:41:41 volumiow systemd[1]: Started Hostname Service. Mar 24 08:41:41 volumiow systemd[1]: systemd-rfkill.service: Succeeded. Mar 24 08:41:41 volumiow nmbd[641]: [2024/03/24 08:41:41.637097, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Mar 24 08:41:41 volumiow nmbd[641]: started asyncdns process 710 Mar 24 08:41:41 volumiow nmbd[641]: [2024/03/24 08:41:41.641145, 0] ../lib/util/become_daemon.c:149(daemon_status) Mar 24 08:41:41 volumiow nmbd[641]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Mar 24 08:41:41 volumiow nmbd[641]: [2024/03/24 08:41:41.641434, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Mar 24 08:41:41 volumiow nmbd[641]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Mar 24 08:41:41 volumiow ntpd[681]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 24 08:41:42 volumiow wireless.js[530]: Cleaning previous... Mar 24 08:41:42 volumiow sudo[718]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 24 08:41:42 volumiow sudo[718]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:41:42 volumiow sudo[718]: pam_unix(sudo:session): session closed for user root Mar 24 08:41:42 volumiow sudo[720]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 24 08:41:42 volumiow sudo[720]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:41:42 volumiow ntpd[681]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 24 08:41:43 volumiow sudo[720]: pam_unix(sudo:session): session closed for user root Mar 24 08:41:43 volumiow wireless.js[530]: Stopped aP Mar 24 08:41:43 volumiow wireless.js[530]: Wireless Networking DISABLED, not starting wireless flow Mar 24 08:41:43 volumiow systemd[1]: wireless.service: Succeeded. Mar 24 08:41:43 volumiow systemd[1]: Started Wireless Services. Mar 24 08:41:43 volumiow systemd[1]: Started Volumio Backend Module. Mar 24 08:41:43 volumiow systemd[1]: Started Volumio Cpu Tweaker. Mar 24 08:41:43 volumiow volumio-cpu-tweak[729]: Setting RT Priority for mpd Mar 24 08:41:43 volumiow volumio-cpu-tweak[729]: pid 35's current scheduling policy: SCHED_OTHER Mar 24 08:41:43 volumiow volumio-cpu-tweak[729]: pid 35's current scheduling priority: 0 Mar 24 08:41:43 volumiow volumio-cpu-tweak[729]: Setting MPD Affinity Mar 24 08:41:43 volumiow volumio-cpu-tweak[729]: pid 3's current affinity mask: f Mar 24 08:41:43 volumiow volumio-cpu-tweak[729]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 24 08:41:43 volumiow volumio-cpu-tweak[729]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 24 08:41:43 volumiow systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 24 08:41:43 volumiow ntpd[681]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 24 08:41:44 volumiow volumio-remote-updater[517]: [2024-03-24 08:41:44] [info] asio async_connect error: system:111 (Connection refused) Mar 24 08:41:44 volumiow volumio-remote-updater[517]: [2024-03-24 08:41:44] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 24 08:41:44 volumiow volumio-remote-updater[517]: [2024-03-24 08:41:44] [error] handle_connect error: Underlying Transport Error Mar 24 08:41:44 volumiow sh[422]: eth0: leased 192.168.0.168 for 86400 seconds Mar 24 08:41:44 volumiow sh[422]: eth0: adding route to 192.168.0.0/24 Mar 24 08:41:44 volumiow sh[422]: eth0: adding default route via 192.168.0.1 Mar 24 08:41:44 volumiow sh[422]: eth0: dhcp_envoption 213: Operation not supported Mar 24 08:41:44 volumiow dhcpcd[467]: eth0: leased 192.168.0.168 for 86400 seconds Mar 24 08:41:44 volumiow dhcpcd[467]: eth0: adding route to 192.168.0.0/24 Mar 24 08:41:44 volumiow dhcpcd[467]: eth0: adding default route via 192.168.0.1 Mar 24 08:41:44 volumiow dhcpcd[467]: eth0: dhcp_envoption 213: Operation not supported Mar 24 08:41:44 volumiow avahi-daemon[536]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.168. Mar 24 08:41:44 volumiow avahi-daemon[536]: New relevant interface eth0.IPv4 for mDNS. Mar 24 08:41:44 volumiow avahi-daemon[536]: Registering new address record for 192.168.0.168 on eth0.IPv4. Mar 24 08:41:44 volumiow sh[422]: forked to background, child pid 765 Mar 24 08:41:44 volumiow dhcpcd[467]: forked to background, child pid 765 Mar 24 08:41:44 volumiow ifplugd(eth0)[679]: client: ifup: interface eth0 already configured Mar 24 08:41:44 volumiow sh[422]: eth0=eth0 Mar 24 08:41:44 volumiow bthelper[633]: Changing power off succeeded Mar 24 08:41:44 volumiow bthelper[633]: [CHG] Controller B8:27:EB:2B:8A:68 Powered: no Mar 24 08:41:44 volumiow bthelper[633]: [CHG] Controller B8:27:EB:2B:8A:68 Discovering: no Mar 24 08:41:44 volumiow bthelper[633]: [CHG] Controller B8:27:EB:2B:8A:68 Class: 0x00000000 Mar 24 08:41:44 volumiow ifplugd(eth0)[679]: Program executed successfully. Mar 24 08:41:44 volumiow ifplugd[610]: Network Interface Plugging Daemon...start eth0...done. Mar 24 08:41:44 volumiow systemd[1]: Started LSB: Brings up/down network automatically. Mar 24 08:41:45 volumiow bthelper[633]: [CHG] Controller B8:27:EB:2B:8A:68 Class: 0x0000041c Mar 24 08:41:45 volumiow bthelper[633]: Changing power on succeeded Mar 24 08:41:45 volumiow ntpd[681]: Listen normally on 3 eth0 192.168.0.168:123 Mar 24 08:41:45 volumiow ntpd[681]: new interface(s) found: waking up resolver Mar 24 08:41:46 volumiow systemd[1]: Started Samba NMB Daemon. Mar 24 08:41:46 volumiow nmbd[641]: [2024/03/24 08:41:46.652100, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 24 08:41:46 volumiow nmbd[641]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 24 08:41:46 volumiow systemd[1]: Starting Samba Winbind Daemon... Mar 24 08:41:47 volumiow winbindd[798]: [2024/03/24 08:41:47.369259, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 24 08:41:47 volumiow winbindd[798]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 24 08:41:47 volumiow winbindd[798]: [2024/03/24 08:41:47.450674, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 24 08:41:47 volumiow winbindd[798]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 24 08:41:47 volumiow systemd[1]: Started Samba Winbind Daemon. Mar 24 08:41:47 volumiow systemd[1]: Starting Samba SMB Daemon... Mar 24 08:41:48 volumiow systemd[1]: Started Samba SMB Daemon. Mar 24 08:41:48 volumiow systemd[1]: Reached target Multi-User System. Mar 24 08:41:48 volumiow systemd[1]: Reached target Graphical Interface. Mar 24 08:41:48 volumiow smbd[803]: [2024/03/24 08:41:48.637436, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 24 08:41:48 volumiow smbd[803]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 24 08:41:48 volumiow systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 24 08:41:48 volumiow systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 24 08:41:48 volumiow systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 24 08:41:48 volumiow systemd[1]: Startup finished in 11.137s (kernel) + 18.872s (userspace) = 30.010s. Mar 24 08:41:49 volumiow volumio[728]: info: ------------------------------------------- Mar 24 08:41:49 volumiow volumio[728]: info: ----- Volumio3 ---- Mar 24 08:41:49 volumiow volumio[728]: info: ------------------------------------------- Mar 24 08:41:49 volumiow volumio[728]: info: ----- System startup ---- Mar 24 08:41:49 volumiow volumio[728]: info: ------------------------------------------- Mar 24 08:41:51 volumiow volumio[728]: info: MYVOLUMIO Environment detected Mar 24 08:41:51 volumiow volumio[728]: info: Plugin folders cleanup Mar 24 08:41:51 volumiow volumio[728]: info: Scanning into folder /volumio/app/plugins/ Mar 24 08:41:51 volumiow volumio[728]: info: Scanning category audio_interface Mar 24 08:41:51 volumiow volumio[728]: info: Scanning category miscellanea Mar 24 08:41:51 volumiow volumio[728]: info: Scanning category music_service Mar 24 08:41:51 volumiow volumio[728]: info: Scanning category plugins.json Mar 24 08:41:51 volumiow volumio[728]: info: Scanning category system_controller Mar 24 08:41:51 volumiow volumio[728]: info: Scanning category user_interface Mar 24 08:41:51 volumiow volumio[728]: info: Scanning into folder /data/plugins/ Mar 24 08:41:51 volumiow volumio[728]: info: Scanning category audio_interface Mar 24 08:41:51 volumiow volumio[728]: info: Scanning category music_service Mar 24 08:41:51 volumiow volumio[728]: info: Scanning category user_interface Mar 24 08:41:51 volumiow volumio[728]: info: Plugin folders cleanup completed Mar 24 08:41:51 volumiow volumio[728]: info: ------------------------------------------- Mar 24 08:41:51 volumiow volumio[728]: info: ----- Core plugins startup ---- Mar 24 08:41:51 volumiow volumio[728]: info: ------------------------------------------- Mar 24 08:41:51 volumiow volumio[728]: info: Loading plugins from folder /volumio/app/plugins/ Mar 24 08:41:51 volumiow volumio[728]: info: Adding plugin upnp to MyMusic Plugins Mar 24 08:41:51 volumiow volumio[728]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 24 08:41:51 volumiow volumio[728]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 24 08:41:51 volumiow volumio[728]: info: Loading plugins from folder /data/plugins/ Mar 24 08:41:51 volumiow volumio[728]: info: Loading plugin "system"... Mar 24 08:41:51 volumiow volumio-remote-updater[517]: [2024-03-24 08:41:51] [connect] Successful connection Mar 24 08:41:51 volumiow volumio[728]: info: Loading plugin "appearance"... Mar 24 08:41:55 volumiow volumio[728]: info: Loading plugin "network"... Mar 24 08:41:55 volumiow volumio[728]: info: Refreshing Cached IP Addresses Mar 24 08:41:55 volumiow volumio[728]: info: Loading plugin "services"... Mar 24 08:41:55 volumiow sudo[826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 24 08:41:55 volumiow sudo[826]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:41:55 volumiow volumio[728]: info: Loading plugin "alsa_controller"... Mar 24 08:41:55 volumiow sudo[828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 24 08:41:55 volumiow sudo[828]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:41:55 volumiow sudo[826]: pam_unix(sudo:session): session closed for user root Mar 24 08:41:55 volumiow sudo[828]: pam_unix(sudo:session): session closed for user root Mar 24 08:41:55 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 24 08:41:55 volumiow volumio[728]: info: Loading plugin "wizard"... Mar 24 08:41:55 volumiow volumio[728]: info: Loading plugin "networkfs"... Mar 24 08:41:56 volumiow volumio[728]: info: Starting Udev Watcher for removable devices Mar 24 08:41:56 volumiow sudo[834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=ivar,password=Ns1bNAS,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.50/music\\ivar /mnt/NAS/NASen Mar 24 08:41:56 volumiow sudo[834]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:41:56 volumiow volumio[728]: info: Ignoring mount for partition: boot Mar 24 08:41:56 volumiow volumio[728]: info: Ignoring mount for partition: volumio Mar 24 08:41:56 volumiow volumio[728]: info: Ignoring mount for partition: volumio_data Mar 24 08:41:56 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 24 08:41:56 volumiow volumio[728]: info: Loading plugin "volumio_command_line_client"... Mar 24 08:41:56 volumiow volumio[728]: info: Loading plugin "upnp"... Mar 24 08:41:56 volumiow volumio[728]: info: [1711266116143] Starting Upmpd Daemon Mar 24 08:41:56 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 24 08:41:56 volumiow volumio[728]: info: Loading plugin "my_music"... Mar 24 08:41:56 volumiow volumio[728]: info: Loading plugin "mpd"... Mar 24 08:41:56 volumiow kernel: Key type cifs.spnego registered Mar 24 08:41:56 volumiow kernel: Key type cifs.idmap registered Mar 24 08:41:56 volumiow 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. Mar 24 08:41:56 volumiow kernel: CIFS: Attempting to mount \\192.168.0.50\music Mar 24 08:41:57 volumiow volumio[728]: info: Loading plugin "upnp_browser"... Mar 24 08:41:57 volumiow volumio[728]: info: Loading plugin "alarm-clock"... Mar 24 08:41:58 volumiow volumio[728]: info: Plugin airplay_emulation is not enabled Mar 24 08:41:58 volumiow volumio[728]: info: Loading plugin "last_100"... Mar 24 08:41:58 volumiow volumio[728]: info: Loading plugin "webradio"... Mar 24 08:41:58 volumiow volumio[728]: info: Loading plugin "i2s_dacs"... Mar 24 08:41:58 volumiow volumio[728]: info: Loading plugin "volumiodiscovery"... Mar 24 08:41:58 volumiow volumio[728]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 24 08:41:58 volumiow node[728]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 24 08:41:58 volumiow volumio[728]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 24 08:41:58 volumiow node[728]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 24 08:41:58 volumiow volumio[728]: *** WARNING *** For more information see Mar 24 08:41:58 volumiow node[728]: *** WARNING *** For more information see Mar 24 08:41:58 volumiow volumio[728]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 24 08:41:58 volumiow node[728]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 24 08:41:58 volumiow volumio[728]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 24 08:41:58 volumiow node[728]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 24 08:41:58 volumiow volumio[728]: *** WARNING *** For more information see Mar 24 08:41:58 volumiow node[728]: *** WARNING *** For more information see Mar 24 08:41:58 volumiow volumio[728]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 24 08:41:58 volumiow volumio[728]: info: Discovery: Started advertising with name: VolumioW Mar 24 08:41:58 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 24 08:41:58 volumiow volumio[728]: info: Loading plugin "spop"... Mar 24 08:42:01 volumiow volumio[728]: info: Loading plugin "outputs"... Mar 24 08:42:01 volumiow volumio[728]: info: Loading plugin "albumart"... Mar 24 08:42:01 volumiow volumio[728]: info: Plugin example_plugin is not enabled Mar 24 08:42:01 volumiow volumio[728]: info: Loading plugin "inputs"... Mar 24 08:42:01 volumiow volumio[728]: info: Loading plugin "updater_comm"... Mar 24 08:42:01 volumiow volumio[728]: info: Plugin mpdemulation is not enabled Mar 24 08:42:01 volumiow volumio[728]: info: Loading plugin "rest_api"... Mar 24 08:42:01 volumiow volumio[728]: info: Loading plugin "websocket"... Mar 24 08:42:01 volumiow volumio[728]: info: Plugin fusiondsp is not enabled Mar 24 08:42:01 volumiow volumio[728]: info: Loading plugin "podcast"... Mar 24 08:42:01 volumiow volumio[728]: Forking 3 albumart workers Mar 24 08:42:02 volumiow volumio[728]: info: ControllerPodcast::constructor Mar 24 08:42:02 volumiow volumio[728]: info: Loading plugin "Systeminfo"... Mar 24 08:42:03 volumiow volumio[728]: info: Loading i18n strings for locale no Mar 24 08:42:03 volumiow volumio[728]: Updating browse sources language Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 08:42:03 volumiow volumio[728]: Starting albumart workers Mar 24 08:42:03 volumiow volumio[728]: Starting albumart workers Mar 24 08:42:03 volumiow volumio[728]: Starting albumart workers Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::initPlayerControls Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 08:42:03 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 08:42:03 volumiow volumio[728]: Express server listening on port 3000 Mar 24 08:42:03 volumiow volumio[728]: [Metrics] WebUI: 16s 788.11ms Mar 24 08:42:04 volumiow volumio[728]: info: CoreStateMachine::resetVolumioState Mar 24 08:42:04 volumiow volumio[728]: info: CoreStateMachine::getcurrentVolume Mar 24 08:42:04 volumiow volumio[728]: info: CoreCommandRouter::volumioRetrievevolume Mar 24 08:42:04 volumiow volumio[728]: info: CoreStateMachine::pushState Mar 24 08:42:04 volumiow volumio[728]: info: CorePlayQueue::getTrack 0 Mar 24 08:42:04 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 08:42:04 volumiow volumio[728]: info: CoreCommandRouter::volumioPushState Mar 24 08:42:04 volumiow volumio[728]: info: Reloading queue from file Mar 24 08:42:04 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 08:42:04 volumiow volumio[728]: info: CoreStateMachine::setRepeat false single undefined Mar 24 08:42:04 volumiow volumio[728]: info: CoreStateMachine::pushState Mar 24 08:42:04 volumiow volumio[728]: info: CorePlayQueue::getTrack 0 Mar 24 08:42:04 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 08:42:04 volumiow volumio[728]: info: CoreCommandRouter::volumioPushState Mar 24 08:42:04 volumiow volumio[728]: info: CoreStateMachine::setRandom null Mar 24 08:42:04 volumiow volumio[728]: info: CoreStateMachine::pushState Mar 24 08:42:04 volumiow volumio[728]: info: CorePlayQueue::getTrack 0 Mar 24 08:42:04 volumiow volumio[728]: info: CoreCommandRouter::volumioPushState Mar 24 08:42:04 volumiow volumio[728]: info: Setting Device type: Raspberry PI Mar 24 08:42:04 volumiow volumio[728]: info: Discovery: adding f6992fa9-99f6-4c77-952e-1ff8a38e4b00 Mar 24 08:42:04 volumiow volumio[728]: info: Discovery: Found device VolumioW Mar 24 08:42:04 volumiow volumio[728]: info: CoreCommandRouter::volumioGetState Mar 24 08:42:04 volumiow volumio[728]: info: CorePlayQueue::getTrack 0 Mar 24 08:42:06 volumiow sudo[915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 24 08:42:06 volumiow sudo[915]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:42:06 volumiow sudo[915]: pam_unix(sudo:session): session closed for user root Mar 24 08:42:06 volumiow sudo[917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 24 08:42:06 volumiow sudo[917]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:42:06 volumiow sudo[917]: pam_unix(sudo:session): session closed for user root Mar 24 08:42:06 volumiow sudo[920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 24 08:42:06 volumiow sudo[920]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:42:06 volumiow systemd[1]: Started UPnP Renderer front-end to MPD. Mar 24 08:42:06 volumiow sudo[920]: pam_unix(sudo:session): session closed for user root Mar 24 08:42:06 volumiow volumio[728]: info: Upmpdcli Daemon Started Mar 24 08:42:06 volumiow volumio[728]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Mar 24 08:42:06 volumiow volumio-remote-updater[517]: [2024-03-24 08:42:06] [connect] Successful connection Mar 24 08:42:06 volumiow volumio-remote-updater[517]: [2024-03-24 08:42:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1711266126 101 Mar 24 08:42:06 volumiow systemd[1]: systemd-fsckd.service: Succeeded. Mar 24 08:42:06 volumiow volumio[728]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Mar 24 08:42:08 volumiow sudo[925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 24 08:42:08 volumiow sudo[925]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:42:08 volumiow sudo[925]: pam_unix(sudo:session): session closed for user root Mar 24 08:42:08 volumiow sudo[927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 24 08:42:08 volumiow sudo[927]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:42:08 volumiow sudo[927]: pam_unix(sudo:session): session closed for user root Mar 24 08:42:09 volumiow volumio[728]: verbose: New Socket.io Connection to 192.168.0.168 from 192.168.0.104 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 2 Mar 24 08:42:09 volumiow sudo[931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 24 08:42:09 volumiow sudo[931]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:42:09 volumiow sudo[931]: pam_unix(sudo:session): session closed for user root Mar 24 08:42:09 volumiow sudo[933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 24 08:42:09 volumiow sudo[933]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 08:42:10 volumiow sudo[933]: pam_unix(sudo:session): session closed for user root Mar 24 08:42:10 volumiow volumio[728]: verbose: New Socket.io Connection to 192.168.0.168 from 192.168.0.104 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 3 Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 24 08:42:10 volumiow volumio[728]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::volumioGetVisibleSources Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::volumioGetState Mar 24 08:42:10 volumiow volumio[728]: info: CorePlayQueue::getTrack 0 Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 24 08:42:10 volumiow volumio[728]: info: Received Get System Info Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 24 08:42:10 volumiow volumio[728]: info: Discovery: Getting this device information Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::volumioGetState Mar 24 08:42:10 volumiow volumio[728]: info: CorePlayQueue::getTrack 0 Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::volumioGetState Mar 24 08:42:10 volumiow volumio[728]: info: CorePlayQueue::getTrack 0 Mar 24 08:42:10 volumiow volumio[728]: info: Listing playlists Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 24 08:42:10 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 24 08:42:11 volumiow volumio[728]: info: CoreCommandRouter::volumioGetState Mar 24 08:42:11 volumiow volumio[728]: info: CorePlayQueue::getTrack 0 Mar 24 08:42:11 volumiow systemd[1]: systemd-hostnamed.service: Succeeded. Mar 24 08:42:11 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 24 08:42:11 volumiow volumio[728]: info: Received Get System Info Mar 24 08:42:11 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 24 08:42:11 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 24 08:42:11 volumiow volumio[728]: info: Discovery: Getting this device information Mar 24 08:42:11 volumiow volumio[728]: info: CoreCommandRouter::volumioGetState Mar 24 08:42:11 volumiow volumio[728]: info: CorePlayQueue::getTrack 0 Mar 24 08:42:11 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 24 08:42:12 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 24 08:42:13 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 24 08:42:13 volumiow volumio[728]: info: Received Get System Info Mar 24 08:42:13 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 24 08:42:13 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 24 08:42:13 volumiow volumio[728]: info: Discovery: Getting this device information Mar 24 08:42:13 volumiow volumio[728]: info: CoreCommandRouter::volumioGetState Mar 24 08:42:13 volumiow volumio[728]: info: CorePlayQueue::getTrack 0 Mar 24 08:42:13 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 24 08:42:13 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 24 08:42:15 volumiow sudo[834]: pam_unix(sudo:session): session closed for user root Mar 24 08:42:16 volumiow volumio[728]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::volumioGetBrowseSources Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::volumioGetBrowseSources Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::volumioGetBrowseSources Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 08:42:20 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 24 08:42:22 volumiow volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 24 08:42:22 volumiow volumio[728]: verbose: ControllerMpd::sendMpdCommand update Mar 24 08:42:22 volumiow volumio[728]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 08:42:22 volumiow volumio[728]: TypeError: Cannot read property 'then' of undefined Mar 24 08:42:22 volumiow volumio[728]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6) Mar 24 08:42:22 volumiow volumio[728]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1898:15) Mar 24 08:42:22 volumiow volumio[728]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) Mar 24 08:42:22 volumiow volumio[728]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1049:26) Mar 24 08:42:22 volumiow volumio[728]: at Socket.emit (events.js:315:20) Mar 24 08:42:22 volumiow volumio[728]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Mar 24 08:42:22 volumiow volumio[728]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Mar 24 08:42:22 volumiow volumio[728]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 08:42:23 volumiow sudo[959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-24 08:41 Mar 24 08:42:23 volumiow sudo[959]: 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" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"