-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Fri 2024-11-15 04:32:59 UTC. -- Nov 15 04:32:11 volumio---upstairs kernel: raspberrypi-firmware soc:firmware: Firmware hash is ddfba3e3c234500025b545512b4b214f28e453e9 Nov 15 04:32:11 volumio---upstairs kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Nov 15 04:32:11 volumio---upstairs kernel: bcm2835-dma fe007000.dma-controller: DMA legacy API manager, dmachans=0x1 Nov 15 04:32:11 volumio---upstairs kernel: SCSI subsystem initialized Nov 15 04:32:11 volumio---upstairs kernel: usbcore: registered new interface driver usbfs Nov 15 04:32:11 volumio---upstairs kernel: usbcore: registered new interface driver hub Nov 15 04:32:11 volumio---upstairs kernel: usbcore: registered new device driver usb Nov 15 04:32:11 volumio---upstairs kernel: pps_core: LinuxPPS API ver. 1 registered Nov 15 04:32:11 volumio---upstairs kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Nov 15 04:32:11 volumio---upstairs kernel: PTP clock support registered Nov 15 04:32:11 volumio---upstairs kernel: vgaarb: loaded Nov 15 04:32:11 volumio---upstairs kernel: clocksource: Switched to clocksource arch_sys_counter Nov 15 04:32:11 volumio---upstairs kernel: VFS: Disk quotas dquot_6.6.0 Nov 15 04:32:11 volumio---upstairs kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Nov 15 04:32:11 volumio---upstairs kernel: FS-Cache: Loaded Nov 15 04:32:11 volumio---upstairs kernel: CacheFiles: Loaded Nov 15 04:32:11 volumio---upstairs kernel: NET: Registered PF_INET protocol family Nov 15 04:32:11 volumio---upstairs kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Nov 15 04:32:11 volumio---upstairs kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear) Nov 15 04:32:11 volumio---upstairs kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 15 04:32:11 volumio---upstairs kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Nov 15 04:32:11 volumio---upstairs kernel: TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) Nov 15 04:32:11 volumio---upstairs kernel: TCP: Hash tables configured (established 8192 bind 8192) Nov 15 04:32:11 volumio---upstairs kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Nov 15 04:32:11 volumio---upstairs kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Nov 15 04:32:11 volumio---upstairs kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 15 04:32:11 volumio---upstairs kernel: RPC: Registered named UNIX socket transport module. Nov 15 04:32:11 volumio---upstairs kernel: RPC: Registered udp transport module. Nov 15 04:32:11 volumio---upstairs kernel: RPC: Registered tcp transport module. Nov 15 04:32:11 volumio---upstairs kernel: RPC: Registered tcp-with-tls transport module. Nov 15 04:32:11 volumio---upstairs kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 15 04:32:11 volumio---upstairs kernel: PCI: CLS 0 bytes, default 64 Nov 15 04:32:11 volumio---upstairs kernel: Trying to unpack rootfs image as initramfs... Nov 15 04:32:11 volumio---upstairs kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available Nov 15 04:32:11 volumio---upstairs kernel: Freeing initrd memory: 28068K Nov 15 04:32:11 volumio---upstairs kernel: Initialise system trusted keyrings Nov 15 04:32:11 volumio---upstairs kernel: workingset: timestamp_bits=14 max_order=20 bucket_order=6 Nov 15 04:32:11 volumio---upstairs kernel: zbud: loaded Nov 15 04:32:11 volumio---upstairs kernel: NFS: Registering the id_resolver key type Nov 15 04:32:11 volumio---upstairs kernel: Key type id_resolver registered Nov 15 04:32:11 volumio---upstairs kernel: Key type id_legacy registered Nov 15 04:32:11 volumio---upstairs kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Nov 15 04:32:11 volumio---upstairs kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Nov 15 04:32:11 volumio---upstairs kernel: Key type asymmetric registered Nov 15 04:32:11 volumio---upstairs kernel: Asymmetric key parser 'x509' registered Nov 15 04:32:11 volumio---upstairs kernel: bounce: pool size: 64 pages Nov 15 04:32:11 volumio---upstairs kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Nov 15 04:32:11 volumio---upstairs kernel: io scheduler mq-deadline registered Nov 15 04:32:11 volumio---upstairs kernel: io scheduler kyber registered Nov 15 04:32:11 volumio---upstairs kernel: io scheduler bfq registered Nov 15 04:32:11 volumio---upstairs kernel: pinctrl-bcm2835 fe200000.gpio: GPIO_OUT persistence: yes Nov 15 04:32:11 volumio---upstairs kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: Nov 15 04:32:11 volumio---upstairs kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] Nov 15 04:32:11 volumio---upstairs kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x067fffffff -> 0x0080000000 Nov 15 04:32:11 volumio---upstairs kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000 Nov 15 04:32:11 volumio---upstairs kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 Nov 15 04:32:11 volumio---upstairs kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 15 04:32:11 volumio---upstairs kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x67fffffff] (bus address [0x80000000-0xffffffff]) Nov 15 04:32:11 volumio---upstairs kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 Nov 15 04:32:11 volumio---upstairs kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Nov 15 04:32:11 volumio---upstairs kernel: PCI: bus0: Fast back to back transfers disabled Nov 15 04:32:11 volumio---upstairs kernel: pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator Nov 15 04:32:11 volumio---upstairs kernel: pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator Nov 15 04:32:11 volumio---upstairs kernel: pci_bus 0000:01: supply vpcie12v not found, using dummy regulator Nov 15 04:32:11 volumio---upstairs kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) Nov 15 04:32:11 volumio---upstairs kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 Nov 15 04:32:11 volumio---upstairs kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Nov 15 04:32:11 volumio---upstairs kernel: pci 0000:01:00.0: PME# supported from D0 D3cold Nov 15 04:32:11 volumio---upstairs kernel: PCI: bus1: Fast back to back transfers disabled Nov 15 04:32:11 volumio---upstairs kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] Nov 15 04:32:11 volumio---upstairs kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] Nov 15 04:32:11 volumio---upstairs kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Nov 15 04:32:11 volumio---upstairs kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] Nov 15 04:32:11 volumio---upstairs kernel: pci 0000:00:00.0: Max Payload Size set to 256/ 512 (was 128), Max Read Rq 512 Nov 15 04:32:11 volumio---upstairs kernel: pci 0000:01:00.0: Max Payload Size set to 256/ 256 (was 128), Max Read Rq 512 Nov 15 04:32:11 volumio---upstairs kernel: pcieport 0000:00:00.0: enabling device (0000 -> 0002) Nov 15 04:32:11 volumio---upstairs kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 45 Nov 15 04:32:11 volumio---upstairs kernel: bcm2708_fb soc:fb: FB found 1 display(s) Nov 15 04:32:11 volumio---upstairs kernel: Console: switching to colour frame buffer device 80x30 Nov 15 04:32:11 volumio---upstairs kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480 Nov 15 04:32:11 volumio---upstairs kernel: iproc-rng200 fe104000.rng: hwrng registered Nov 15 04:32:11 volumio---upstairs kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Nov 15 04:32:11 volumio---upstairs kernel: brd: module loaded Nov 15 04:32:11 volumio---upstairs kernel: loop: module loaded Nov 15 04:32:11 volumio---upstairs kernel: Loading iSCSI transport class v2.0-870. Nov 15 04:32:11 volumio---upstairs kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 Nov 15 04:32:11 volumio---upstairs kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus Nov 15 04:32:11 volumio---upstairs kernel: usbcore: registered new device driver r8152-cfgselector Nov 15 04:32:11 volumio---upstairs kernel: usbcore: registered new interface driver r8152 Nov 15 04:32:11 volumio---upstairs kernel: usbcore: registered new interface driver lan78xx Nov 15 04:32:11 volumio---upstairs kernel: usbcore: registered new interface driver smsc95xx Nov 15 04:32:11 volumio---upstairs kernel: xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142) Nov 15 04:32:11 volumio---upstairs kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Nov 15 04:32:11 volumio---upstairs kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 Nov 15 04:32:11 volumio---upstairs kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0700240000000890 Nov 15 04:32:11 volumio---upstairs kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Nov 15 04:32:11 volumio---upstairs kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 Nov 15 04:32:11 volumio---upstairs kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed Nov 15 04:32:11 volumio---upstairs kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Nov 15 04:32:11 volumio---upstairs kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 15 04:32:11 volumio---upstairs kernel: usb usb1: Product: xHCI Host Controller Nov 15 04:32:11 volumio---upstairs kernel: usb usb1: Manufacturer: Linux 6.6.56-v7l+ xhci-hcd Nov 15 04:32:11 volumio---upstairs kernel: usb usb1: SerialNumber: 0000:01:00.0 Nov 15 04:32:11 volumio---upstairs kernel: hub 1-0:1.0: USB hub found Nov 15 04:32:11 volumio---upstairs kernel: hub 1-0:1.0: 1 port detected Nov 15 04:32:11 volumio---upstairs kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Nov 15 04:32:11 volumio---upstairs kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 15 04:32:11 volumio---upstairs kernel: usb usb2: Product: xHCI Host Controller Nov 15 04:32:11 volumio---upstairs kernel: usb usb2: Manufacturer: Linux 6.6.56-v7l+ xhci-hcd Nov 15 04:32:11 volumio---upstairs kernel: usb usb2: SerialNumber: 0000:01:00.0 Nov 15 04:32:11 volumio---upstairs kernel: hub 2-0:1.0: USB hub found Nov 15 04:32:11 volumio---upstairs kernel: hub 2-0:1.0: 4 ports detected Nov 15 04:32:11 volumio---upstairs kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Nov 15 04:32:11 volumio---upstairs kernel: dwc_otg: FIQ enabled Nov 15 04:32:11 volumio---upstairs kernel: dwc_otg: NAK holdoff enabled Nov 15 04:32:11 volumio---upstairs kernel: dwc_otg: FIQ split-transaction FSM enabled Nov 15 04:32:11 volumio---upstairs kernel: Module dwc_common_port init Nov 15 04:32:11 volumio---upstairs kernel: usbcore: registered new interface driver uas Nov 15 04:32:11 volumio---upstairs kernel: usbcore: registered new interface driver usb-storage Nov 15 04:32:11 volumio---upstairs kernel: mousedev: PS/2 mouse device common for all mice Nov 15 04:32:11 volumio---upstairs kernel: sdhci: Secure Digital Host Controller Interface driver Nov 15 04:32:11 volumio---upstairs kernel: sdhci: Copyright(c) Pierre Ossman Nov 15 04:32:11 volumio---upstairs kernel: sdhci-pltfm: SDHCI platform and OF driver helper Nov 15 04:32:11 volumio---upstairs kernel: ledtrig-cpu: registered to indicate activity on CPUs Nov 15 04:32:11 volumio---upstairs kernel: hid: raw HID events driver (C) Jiri Kosina Nov 15 04:32:11 volumio---upstairs kernel: usbcore: registered new interface driver usbhid Nov 15 04:32:11 volumio---upstairs kernel: usbhid: USB HID core driver Nov 15 04:32:11 volumio---upstairs kernel: Initializing XFRM netlink socket Nov 15 04:32:11 volumio---upstairs kernel: NET: Registered PF_PACKET protocol family Nov 15 04:32:11 volumio---upstairs kernel: Key type dns_resolver registered Nov 15 04:32:11 volumio---upstairs kernel: Registering SWP/SWPB emulation handler Nov 15 04:32:11 volumio---upstairs kernel: registered taskstats version 1 Nov 15 04:32:11 volumio---upstairs kernel: Loading compiled-in X.509 certificates Nov 15 04:32:11 volumio---upstairs kernel: Key type .fscrypt registered Nov 15 04:32:11 volumio---upstairs kernel: Key type fscrypt-provisioning registered Nov 15 04:32:11 volumio---upstairs kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Nov 15 04:32:11 volumio---upstairs kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Nov 15 04:32:11 volumio---upstairs kernel: fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 51, base_baud = 0) is a PL011 rev2 Nov 15 04:32:11 volumio---upstairs kernel: serial serial0: tty port ttyAMA1 registered Nov 15 04:32:11 volumio---upstairs kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Nov 15 04:32:11 volumio---upstairs kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Nov 15 04:32:11 volumio---upstairs kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Nov 15 04:32:11 volumio---upstairs kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Nov 15 04:32:11 volumio---upstairs kernel: of_cfs_init Nov 15 04:32:11 volumio---upstairs kernel: of_cfs_init: OK Nov 15 04:32:11 volumio---upstairs kernel: clk: Disabling unused clocks Nov 15 04:32:11 volumio---upstairs kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Nov 15 04:32:11 volumio---upstairs kernel: Freeing unused kernel image (initmem) memory: 2048K Nov 15 04:32:11 volumio---upstairs kernel: Run /init as init process Nov 15 04:32:11 volumio---upstairs kernel: with arguments: Nov 15 04:32:11 volumio---upstairs kernel: /init Nov 15 04:32:11 volumio---upstairs kernel: splash Nov 15 04:32:11 volumio---upstairs kernel: nodebug Nov 15 04:32:11 volumio---upstairs kernel: with environment: Nov 15 04:32:11 volumio---upstairs kernel: HOME=/ Nov 15 04:32:11 volumio---upstairs kernel: TERM=linux Nov 15 04:32:11 volumio---upstairs kernel: imgpart=UUID=aad048ad-7eb3-4549-8020-f5742baed86d Nov 15 04:32:11 volumio---upstairs kernel: imgfile=/volumio_current.sqsh Nov 15 04:32:11 volumio---upstairs kernel: bootpart=UUID=5883-B9C7 Nov 15 04:32:11 volumio---upstairs kernel: datapart=UUID=cfbe554b-d5ac-4dfd-b89b-effce104ffff Nov 15 04:32:11 volumio---upstairs kernel: uuidconfig=cmdline.txt Nov 15 04:32:11 volumio---upstairs kernel: pcie_aspm=off Nov 15 04:32:11 volumio---upstairs kernel: bootdelay=7 Nov 15 04:32:11 volumio---upstairs kernel: use_kmsg=no Nov 15 04:32:11 volumio---upstairs kernel: mmc1: new high speed SDIO card at address 0001 Nov 15 04:32:11 volumio---upstairs kernel: mmc0: new ultra high speed DDR50 SDHC card at address 0001 Nov 15 04:32:11 volumio---upstairs kernel: mmcblk0: mmc0:0001 SD32G 28.9 GiB Nov 15 04:32:11 volumio---upstairs kernel: mmcblk0: p1 p2 p3 Nov 15 04:32:11 volumio---upstairs kernel: mmcblk0: mmc0:0001 SD32G 28.9 GiB Nov 15 04:32:11 volumio---upstairs kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Nov 15 04:32:11 volumio---upstairs kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Nov 15 04:32:11 volumio---upstairs kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Nov 15 04:32:11 volumio---upstairs kernel: usb 1-1: Product: USB2.0 Hub Nov 15 04:32:11 volumio---upstairs kernel: hub 1-1:1.0: USB hub found Nov 15 04:32:11 volumio---upstairs kernel: hub 1-1:1.0: 4 ports detected Nov 15 04:32:11 volumio---upstairs kernel: usb 1-1.2: new high-speed USB device number 3 using xhci_hcd Nov 15 04:32:11 volumio---upstairs kernel: fuse: init (API version 7.39) Nov 15 04:32:11 volumio---upstairs kernel: usb 1-1.2: New USB device found, idVendor=25c4, idProduct=0008, bcdDevice= 1.61 Nov 15 04:32:11 volumio---upstairs kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Nov 15 04:32:11 volumio---upstairs kernel: usb 1-1.2: Product: irDAC II Nov 15 04:32:11 volumio---upstairs kernel: usb 1-1.2: Manufacturer: ARCAM Nov 15 04:32:11 volumio---upstairs kernel: input: ARCAM irDAC II as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:25C4:0008.0001/input/input0 Nov 15 04:32:11 volumio---upstairs kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 15 04:32:11 volumio---upstairs kernel: hid-generic 0003:25C4:0008.0001: input,hidraw0: USB HID v1.10 Device [ARCAM irDAC II] on usb-0000:01:00.0-1.2/input3 Nov 15 04:32:11 volumio---upstairs kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Nov 15 04:32:11 volumio---upstairs kernel: EXT4-fs (mmcblk0p2): recovery complete Nov 15 04:32:11 volumio---upstairs kernel: EXT4-fs (mmcblk0p2): mounted filesystem aad048ad-7eb3-4549-8020-f5742baed86d r/w with ordered data mode. Quota mode: none. Nov 15 04:32:11 volumio---upstairs kernel: loop0: detected capacity change from 0 to 994880 Nov 15 04:32:11 volumio---upstairs kernel: EXT4-fs (mmcblk0p3): recovery complete Nov 15 04:32:11 volumio---upstairs kernel: EXT4-fs (mmcblk0p3): mounted filesystem cfbe554b-d5ac-4dfd-b89b-effce104ffff r/w with ordered data mode. Quota mode: none. Nov 15 04:32:11 volumio---upstairs systemd[1]: System time before build time, advancing clock. Nov 15 04:32:11 volumio---upstairs kernel: NET: Registered PF_INET6 protocol family Nov 15 04:32:11 volumio---upstairs kernel: Segment Routing with IPv6 Nov 15 04:32:11 volumio---upstairs kernel: In-situ OAM (IOAM) with IPv6 Nov 15 04:32:11 volumio---upstairs 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) Nov 15 04:32:11 volumio---upstairs systemd[1]: Detected architecture arm. Nov 15 04:32:11 volumio---upstairs systemd[1]: Set hostname to . Nov 15 04:32:11 volumio---upstairs 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. Nov 15 04:32:11 volumio---upstairs systemd[1]: Listening on Journal Socket (/dev/log). Nov 15 04:32:11 volumio---upstairs systemd[1]: Listening on Journal Audit Socket. Nov 15 04:32:11 volumio---upstairs systemd[1]: Listening on fsck to fsckd communication Socket. Nov 15 04:32:11 volumio---upstairs systemd[1]: Listening on Journal Socket. Nov 15 04:32:11 volumio---upstairs systemd[1]: Starting Remount Root and Kernel File Systems... Nov 15 04:32:11 volumio---upstairs systemd[1]: Condition check resulted in Huge Pages File System being skipped. Nov 15 04:32:11 volumio---upstairs kernel: i2c_dev: i2c /dev entries driver Nov 15 04:32:11 volumio---upstairs systemd-journald[319]: Journal started Nov 15 04:32:11 volumio---upstairs systemd-journald[319]: Runtime journal (/run/log/journal/b09207998001defae5f73bf26405b501) is 7.5M, max 30.0M, 22.5M free. Nov 15 04:32:11 volumio---upstairs systemd-modules-load[304]: Inserted module 'i2c_dev' Nov 15 04:32:11 volumio---upstairs fake-hwclock[305]: Fri Nov 15 04:32:11 UTC 2024 Nov 15 04:32:11 volumio---upstairs systemd[1]: Started Load/Save Random Seed. Nov 15 04:32:11 volumio---upstairs systemd[1]: dynamicswap.service: Succeeded. Nov 15 04:32:11 volumio---upstairs systemd[1]: Started Create System Users. Nov 15 04:32:11 volumio---upstairs systemd[1]: Starting Create Static Device Nodes in /dev... Nov 15 04:32:11 volumio---upstairs systemd[1]: Started udev Coldplug all Devices. Nov 15 04:32:11 volumio---upstairs systemd[1]: Starting Helper to synchronize boot up for ifupdown... Nov 15 04:32:11 volumio---upstairs systemd[1]: Started Helper to synchronize boot up for ifupdown. Nov 15 04:32:11 volumio---upstairs systemd[1]: Started Create Static Device Nodes in /dev. Nov 15 04:32:11 volumio---upstairs systemd[1]: Reached target Local File Systems (Pre). Nov 15 04:32:11 volumio---upstairs systemd[1]: Mounting /var/spool/cups... Nov 15 04:32:11 volumio---upstairs systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Nov 15 04:32:11 volumio---upstairs systemd[1]: Mounting /var/log... Nov 15 04:32:11 volumio---upstairs systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Nov 15 04:32:11 volumio---upstairs systemd[1]: Mounting /tmp... Nov 15 04:32:11 volumio---upstairs systemd[1]: Starting udev Kernel Device Manager... Nov 15 04:32:11 volumio---upstairs systemd[1]: Mounted /var/spool/cups. Nov 15 04:32:11 volumio---upstairs systemd[1]: Mounted /var/log. Nov 15 04:32:11 volumio---upstairs systemd[1]: Mounted /tmp. Nov 15 04:32:11 volumio---upstairs systemd[1]: Starting Flush Journal to Persistent Storage... Nov 15 04:32:11 volumio---upstairs systemd[1]: Mounting /var/spool/cups/tmp... Nov 15 04:32:11 volumio---upstairs systemd[1]: Mounted /var/spool/cups/tmp. Nov 15 04:32:11 volumio---upstairs systemd-udevd[345]: Network interface NamePolicy= disabled on kernel command line, ignoring. Nov 15 04:32:11 volumio---upstairs systemd-journald[319]: Runtime journal (/run/log/journal/b09207998001defae5f73bf26405b501) is 7.5M, max 30.0M, 22.5M free. Nov 15 04:32:11 volumio---upstairs systemd[1]: Started Flush Journal to Persistent Storage. Nov 15 04:32:11 volumio---upstairs systemd[1]: Started udev Kernel Device Manager. Nov 15 04:32:11 volumio---upstairs systemd[1]: Starting Show Plymouth Boot Screen... Nov 15 04:32:11 volumio---upstairs systemd[1]: plymouth-start.service: Succeeded. Nov 15 04:32:11 volumio---upstairs systemd[1]: Started Show Plymouth Boot Screen. Nov 15 04:32:11 volumio---upstairs systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Nov 15 04:32:11 volumio---upstairs systemd[1]: Reached target Paths. Nov 15 04:32:11 volumio---upstairs systemd[1]: Reached target Local Encrypted Volumes. Nov 15 04:32:11 volumio---upstairs systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Nov 15 04:32:11 volumio---upstairs kernel: rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000 Nov 15 04:32:11 volumio---upstairs kernel: rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem Nov 15 04:32:11 volumio---upstairs kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Nov 15 04:32:12 volumio---upstairs systemd-udevd[363]: Using default interface naming scheme 'v240'. Nov 15 04:32:12 volumio---upstairs kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Nov 15 04:32:12 volumio---upstairs kernel: [vc_sm_connected_init]: start Nov 15 04:32:12 volumio---upstairs kernel: [vc_sm_connected_init]: installed successfully Nov 15 04:32:12 volumio---upstairs kernel: mc: Linux media interface: v0.10 Nov 15 04:32:12 volumio---upstairs systemd-udevd[363]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Nov 15 04:32:12 volumio---upstairs kernel: videodev: Linux video capture interface: v2.00 Nov 15 04:32:12 volumio---upstairs kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Nov 15 04:32:12 volumio---upstairs kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Nov 15 04:32:12 volumio---upstairs kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Nov 15 04:32:12 volumio---upstairs kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Nov 15 04:32:12 volumio---upstairs kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Nov 15 04:32:12 volumio---upstairs kernel: rpivid feb10000.codec: Device registered as /dev/video19 Nov 15 04:32:12 volumio---upstairs kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Nov 15 04:32:12 volumio---upstairs kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Nov 15 04:32:12 volumio---upstairs kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Nov 15 04:32:12 volumio---upstairs kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Nov 15 04:32:12 volumio---upstairs kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Nov 15 04:32:12 volumio---upstairs kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Nov 15 04:32:12 volumio---upstairs kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Nov 15 04:32:12 volumio---upstairs kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Nov 15 04:32:12 volumio---upstairs systemd-udevd[378]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Nov 15 04:32:13 volumio---upstairs kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Nov 15 04:32:13 volumio---upstairs kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Nov 15 04:32:13 volumio---upstairs systemd[1]: Found device /dev/disk/by-uuid/5883-B9C7. Nov 15 04:32:13 volumio---upstairs kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Nov 15 04:32:13 volumio---upstairs kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Nov 15 04:32:13 volumio---upstairs kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Nov 15 04:32:13 volumio---upstairs kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Nov 15 04:32:13 volumio---upstairs kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Nov 15 04:32:13 volumio---upstairs kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Nov 15 04:32:13 volumio---upstairs kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Nov 15 04:32:13 volumio---upstairs kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Nov 15 04:32:13 volumio---upstairs kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Nov 15 04:32:13 volumio---upstairs kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: Core ver 2.22 Nov 15 04:32:13 volumio---upstairs kernel: NET: Registered PF_BLUETOOTH protocol family Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: HCI device and connection manager initialized Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: HCI socket layer initialized Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: L2CAP socket layer initialized Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: SCO socket layer initialized Nov 15 04:32:13 volumio---upstairs kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Nov 15 04:32:13 volumio---upstairs kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Nov 15 04:32:13 volumio---upstairs kernel: usbcore: registered new interface driver brcmfmac Nov 15 04:32:13 volumio---upstairs systemd-udevd[354]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: HCI UART driver ver 2.3 Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: HCI UART protocol H4 registered Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: HCI UART protocol Broadcom registered Nov 15 04:32:13 volumio---upstairs kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Nov 15 04:32:13 volumio---upstairs kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Nov 15 04:32:13 volumio---upstairs kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Nov 15 04:32:13 volumio---upstairs kernel: uart-pl011 fe201000.serial: no DMA platform data Nov 15 04:32:13 volumio---upstairs kernel: usbcore: registered new interface driver snd-usb-audio Nov 15 04:32:13 volumio---upstairs systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Nov 15 04:32:13 volumio---upstairs kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Nov 15 04:32:13 volumio---upstairs 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 Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: hci0: BCM: chip id 107 Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: hci0: BCM: features 0x2f Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: hci0: BCM4345C0 Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Nov 15 04:32:13 volumio---upstairs kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Nov 15 04:32:14 volumio---upstairs systemd-udevd[362]: Using default interface naming scheme 'v240'. Nov 15 04:32:14 volumio---upstairs systemd-udevd[362]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Nov 15 04:32:14 volumio---upstairs kernel: alsactl[484]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Nov 15 04:32:14 volumio---upstairs systemd[1]: Created slice system-bthelper.slice. Nov 15 04:32:14 volumio---upstairs systemd[1]: Condition check resulted in Huge Pages File System being skipped. Nov 15 04:32:14 volumio---upstairs systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Nov 15 04:32:14 volumio---upstairs systemd[1]: Starting Show Plymouth Boot Screen... Nov 15 04:32:14 volumio---upstairs systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 15 04:32:14 volumio---upstairs systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Nov 15 04:32:14 volumio---upstairs systemd[1]: Starting File System Check on /dev/disk/by-uuid/5883-B9C7... Nov 15 04:32:14 volumio---upstairs systemd-udevd[349]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Nov 15 04:32:14 volumio---upstairs systemd[1]: Started File System Check Daemon to report status. Nov 15 04:32:14 volumio---upstairs systemd[1]: Starting Load/Save RF Kill Switch Status... Nov 15 04:32:14 volumio---upstairs systemd[1]: plymouth-start.service: Succeeded. Nov 15 04:32:14 volumio---upstairs systemd[1]: Started Show Plymouth Boot Screen. Nov 15 04:32:14 volumio---upstairs systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Nov 15 04:32:14 volumio---upstairs systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Nov 15 04:32:14 volumio---upstairs systemd[1]: Started Load/Save RF Kill Switch Status. Nov 15 04:32:14 volumio---upstairs systemd-fsck[505]: fsck.fat 4.1 (2017-01-24) Nov 15 04:32:14 volumio---upstairs systemd-fsck[505]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Nov 15 04:32:14 volumio---upstairs systemd-fsck[505]: Automatically removing dirty bit. Nov 15 04:32:14 volumio---upstairs systemd-fsck[505]: Performing changes. Nov 15 04:32:14 volumio---upstairs systemd-fsck[505]: /dev/mmcblk0p1: 407 files, 41694/46774 clusters Nov 15 04:32:14 volumio---upstairs kernel: Bluetooth: hci0: BCM: features 0x2f Nov 15 04:32:14 volumio---upstairs kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Nov 15 04:32:14 volumio---upstairs kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Nov 15 04:32:14 volumio---upstairs systemd[1]: Started File System Check on /dev/disk/by-uuid/5883-B9C7. Nov 15 04:32:14 volumio---upstairs systemd[1]: Mounting /boot... Nov 15 04:32:14 volumio---upstairs systemd[1]: Mounted /boot. Nov 15 04:32:14 volumio---upstairs systemd[1]: Reached target Local File Systems. Nov 15 04:32:14 volumio---upstairs systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Nov 15 04:32:14 volumio---upstairs systemd[1]: Started ifup for eth0. Nov 15 04:32:14 volumio---upstairs systemd[1]: Starting Raise network interfaces... Nov 15 04:32:14 volumio---upstairs systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Nov 15 04:32:14 volumio---upstairs systemd[1]: Starting Preprocess NFS configuration... Nov 15 04:32:14 volumio---upstairs systemd[1]: Started ifup for wlan0. Nov 15 04:32:14 volumio---upstairs systemd[1]: Starting Create Volatile Files and Directories... Nov 15 04:32:14 volumio---upstairs systemd[1]: plymouth-read-write.service: Succeeded. Nov 15 04:32:14 volumio---upstairs systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Nov 15 04:32:15 volumio---upstairs systemd[1]: Received SIGRTMIN+20 from PID 200 (plymouthd). Nov 15 04:32:15 volumio---upstairs systemd[1]: nfs-config.service: Succeeded. Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Preprocess NFS configuration. Nov 15 04:32:15 volumio---upstairs systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Nov 15 04:32:15 volumio---upstairs systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Nov 15 04:32:15 volumio---upstairs systemd[1]: Reached target NFS client services. Nov 15 04:32:15 volumio---upstairs kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Create Volatile Files and Directories. Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting Update UTMP about System Boot/Shutdown... Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting RPC bind portmap service... Nov 15 04:32:15 volumio---upstairs kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 15 04:32:15 volumio---upstairs systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Nov 15 04:32:15 volumio---upstairs kernel: 8021q: 802.1Q VLAN Support v1.8 Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Update UTMP about System Boot/Shutdown. Nov 15 04:32:15 volumio---upstairs systemd[1]: Reached target System Initialization. Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 15 04:32:15 volumio---upstairs systemd[1]: Listening on triggerhappy.socket. Nov 15 04:32:15 volumio---upstairs systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 15 04:32:15 volumio---upstairs systemd[1]: apt-daily.timer: Not using persistent file timestamp Mon 2024-12-02 01:38:09 UTC as it is in the future. Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Daily apt download activities. Nov 15 04:32:15 volumio---upstairs systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Mon 2024-12-02 06:03:20 UTC as it is in the future. Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Daily apt upgrade and clean activities. Nov 15 04:32:15 volumio---upstairs systemd[1]: Reached target Timers. Nov 15 04:32:15 volumio---upstairs systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Nov 15 04:32:15 volumio---upstairs systemd[1]: Reached target Sockets. Nov 15 04:32:15 volumio---upstairs systemd[1]: Reached target Basic System. Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting Volumio Time Update Utility... Nov 15 04:32:15 volumio---upstairs systemd[1]: Started D-Bus System Message Bus. Nov 15 04:32:15 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Fetching time from Volumio... Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting Login Service... Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting Wireless Services... Nov 15 04:32:15 volumio---upstairs kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Nov 15 04:32:15 volumio---upstairs kernel: bcmgenet fd580000.ethernet eth0: Link is Down Nov 15 04:32:15 volumio---upstairs sh[515]: eth0: waiting for carrier Nov 15 04:32:15 volumio---upstairs dhcpcd[567]: eth0: waiting for carrier Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting Configure Bluetooth Modems connected by UART... Nov 15 04:32:15 volumio---upstairs systemd[1]: Started UPnP Renderer front-end to MPD. Nov 15 04:32:15 volumio---upstairs systemd[1]: Started volumio-remote-updater.service. Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting WPA supplicant... Nov 15 04:32:15 volumio---upstairs systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Nov 15 04:32:15 volumio---upstairs systemd[1]: Started MPD Monitor Service. Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Manage Sound Card State (restore and store). Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting Save/Restore Sound Card State... Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting triggerhappy global hotkey daemon... Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Volumio Iptables Module. Nov 15 04:32:15 volumio---upstairs systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Nov 15 04:32:15 volumio---upstairs alsactl[644]: alsactl 1.1.8 daemon started Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Volumio Log Rotation Service. Nov 15 04:32:15 volumio---upstairs systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting dhcpcd on all interfaces... Nov 15 04:32:15 volumio---upstairs systemd[1]: Started RPC bind portmap service. Nov 15 04:32:15 volumio---upstairs systemd[1]: Reached target RPC Port Mapper. Nov 15 04:32:15 volumio---upstairs systemd[1]: Reached target Remote File Systems (Pre). Nov 15 04:32:15 volumio---upstairs systemd[1]: Reached target Remote File Systems. Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Nov 15 04:32:15 volumio---upstairs systemd[1]: hciuart.service: Succeeded. Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Configure Bluetooth Modems connected by UART. Nov 15 04:32:15 volumio---upstairs systemd[1]: Started Save/Restore Sound Card State. Nov 15 04:32:15 volumio---upstairs dhcpcd[649]: Not running dhcpcd because /etc/network/interfaces Nov 15 04:32:15 volumio---upstairs dhcpcd[649]: defines some interfaces that will use a Nov 15 04:32:15 volumio---upstairs dhcpcd[649]: DHCP client or static address Nov 15 04:32:15 volumio---upstairs systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Nov 15 04:32:15 volumio---upstairs systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Nov 15 04:32:15 volumio---upstairs systemd[1]: Failed to start dhcpcd on all interfaces. Nov 15 04:32:15 volumio---upstairs systemd[1]: Reached target Sound Card. Nov 15 04:32:15 volumio---upstairs thd[646]: Unable to parse trigger line: Nov 15 04:32:15 volumio---upstairs thd[646]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Nov 15 04:32:15 volumio---upstairs thd[646]: Unable to parse trigger line: Nov 15 04:32:15 volumio---upstairs thd[646]: Unable to parse trigger line: Nov 15 04:32:15 volumio---upstairs thd[646]: Found socket passed from systemd Nov 15 04:32:15 volumio---upstairs systemd[1]: Starting Raspberry Pi bluetooth helper... Nov 15 04:32:15 volumio---upstairs systemd-logind[634]: New seat seat0. Nov 15 04:32:15 volumio---upstairs systemd[1]: Started triggerhappy global hotkey daemon. Nov 15 04:32:15 volumio---upstairs sh[520]: wlan0=wlan0 Nov 15 04:32:16 volumio---upstairs avahi-daemon[636]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Nov 15 04:32:16 volumio---upstairs avahi-daemon[636]: Successfully dropped root privileges. Nov 15 04:32:16 volumio---upstairs avahi-daemon[636]: avahi-daemon 0.7 starting up. Nov 15 04:32:16 volumio---upstairs mpd_monitor.sh[643]: MPD error: Connection refused Nov 15 04:32:16 volumio---upstairs mpd_monitor.sh[643]: mpd: no process found Nov 15 04:32:16 volumio---upstairs bthelper[664]: Raspberry Pi BDADDR already set Nov 15 04:32:16 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Date not found in response Nov 15 04:32:16 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Retrying in 5 seconds... Nov 15 04:32:16 volumio---upstairs volumio-remote-updater[639]: Error: No active session Nov 15 04:32:16 volumio---upstairs volumio-remote-updater[639]: [2024-11-15 04:32:16] [info] asio async_connect error: system:111 (Connection refused) Nov 15 04:32:16 volumio---upstairs volumio-remote-updater[639]: [2024-11-15 04:32:16] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 15 04:32:16 volumio---upstairs volumio-remote-updater[639]: [2024-11-15 04:32:16] [error] handle_connect error: Underlying Transport Error Nov 15 04:32:16 volumio---upstairs dbus-daemon[626]: [system] Successfully activated service 'org.freedesktop.systemd1' Nov 15 04:32:16 volumio---upstairs systemd[1]: Started Avahi mDNS/DNS-SD Stack. Nov 15 04:32:16 volumio---upstairs avahi-daemon[636]: Successfully called chroot(). Nov 15 04:32:16 volumio---upstairs avahi-daemon[636]: Successfully dropped remaining capabilities. Nov 15 04:32:16 volumio---upstairs systemd[1]: Started Login Service. Nov 15 04:32:16 volumio---upstairs systemd[1]: Started Raspberry Pi bluetooth helper. Nov 15 04:32:16 volumio---upstairs wpa_supplicant[641]: Successfully initialized wpa_supplicant Nov 15 04:32:16 volumio---upstairs avahi-daemon[636]: Loading service file /services/volumio.service. Nov 15 04:32:16 volumio---upstairs avahi-daemon[636]: Network interface enumeration completed. Nov 15 04:32:16 volumio---upstairs avahi-daemon[636]: Server startup complete. Host name is volumio---upstairs.local. Local service cookie is 3421495640. Nov 15 04:32:16 volumio---upstairs avahi-daemon[636]: Service "Volumio - Upstairs" (/services/volumio.service) successfully established. Nov 15 04:32:16 volumio---upstairs systemd[1]: Started Raise network interfaces. Nov 15 04:32:16 volumio---upstairs systemd[1]: Started WPA supplicant. Nov 15 04:32:16 volumio---upstairs volumio[638]: Could not open config: /tmp/upmpdcli.conf Nov 15 04:32:16 volumio---upstairs systemd[1]: Listening on mpd.socket. Nov 15 04:32:16 volumio---upstairs systemd[1]: Reached target Network. Nov 15 04:32:16 volumio---upstairs systemd[1]: Starting Permit User Sessions... Nov 15 04:32:16 volumio---upstairs systemd[1]: Reached target Network is Online. Nov 15 04:32:16 volumio---upstairs systemd[1]: Starting LSB: Brings up/down network automatically... Nov 15 04:32:16 volumio---upstairs systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Nov 15 04:32:17 volumio---upstairs systemd[1]: Starting Network Time Service... Nov 15 04:32:17 volumio---upstairs systemd[1]: Starting Samba NMB Daemon... Nov 15 04:32:17 volumio---upstairs systemd[1]: Starting /etc/rc.local Compatibility... Nov 15 04:32:17 volumio---upstairs systemd[1]: Starting Music Player Daemon... Nov 15 04:32:17 volumio---upstairs systemd[1]: Starting Bluetooth service... Nov 15 04:32:17 volumio---upstairs systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 15 04:32:17 volumio---upstairs systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Nov 15 04:32:17 volumio---upstairs systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Nov 15 04:32:17 volumio---upstairs systemd[1]: Started Permit User Sessions. Nov 15 04:32:17 volumio---upstairs systemd[1]: Started /etc/rc.local Compatibility. Nov 15 04:32:17 volumio---upstairs systemd[1]: Starting Hold until boot process finishes up... Nov 15 04:32:17 volumio---upstairs systemd[1]: Starting Terminate Plymouth Boot Screen... Nov 15 04:32:17 volumio---upstairs systemd[1]: Received SIGRTMIN+21 from PID 200 (plymouthd). Nov 15 04:32:17 volumio---upstairs systemd[1]: iptables.service: Succeeded. Nov 15 04:32:17 volumio---upstairs systemd[1]: Received SIGRTMIN+21 from PID 200 (plymouthd). Nov 15 04:32:17 volumio---upstairs systemd[1]: plymouth-quit-wait.service: Succeeded. Nov 15 04:32:17 volumio---upstairs systemd[1]: Started Hold until boot process finishes up. Nov 15 04:32:17 volumio---upstairs systemd[1]: plymouth-quit.service: Succeeded. Nov 15 04:32:17 volumio---upstairs systemd[1]: Started Terminate Plymouth Boot Screen. Nov 15 04:32:17 volumio---upstairs systemd[1]: Started Getty on tty1. Nov 15 04:32:17 volumio---upstairs systemd[1]: Reached target Login Prompts. Nov 15 04:32:17 volumio---upstairs ifplugd(eth0)[783]: ifplugd 0.28 initializing. Nov 15 04:32:17 volumio---upstairs ifplugd(eth0)[783]: Using interface eth0/DC:A6:32:A1:DF:5B with driver (version: 6.6.56-v7l+) Nov 15 04:32:17 volumio---upstairs ifplugd(eth0)[783]: Using detection mode: SIOCETHTOOL Nov 15 04:32:17 volumio---upstairs ifplugd(eth0)[783]: Initialization complete, link beat not detected. Nov 15 04:32:17 volumio---upstairs sh[515]: eth0: carrier acquired Nov 15 04:32:17 volumio---upstairs dhcpcd[567]: eth0: carrier acquired Nov 15 04:32:17 volumio---upstairs loadcpufreq[654]: Loading cpufreq kernel modules...done (none). Nov 15 04:32:17 volumio---upstairs kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx Nov 15 04:32:17 volumio---upstairs systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Nov 15 04:32:17 volumio---upstairs systemd[1]: Starting LSB: set CPUFreq kernel parameters... Nov 15 04:32:17 volumio---upstairs sh[515]: DUID 00:01:00:01:2b:98:73:3b:dc:a6:32:a1:df:5b Nov 15 04:32:17 volumio---upstairs sh[515]: eth0: IAID 32:a1:df:5b Nov 15 04:32:17 volumio---upstairs dhcpcd[567]: DUID 00:01:00:01:2b:98:73:3b:dc:a6:32:a1:df:5b Nov 15 04:32:17 volumio---upstairs sh[515]: eth0: adding address fe80::9870:da1d:675:8026 Nov 15 04:32:17 volumio---upstairs sh[515]: ipv6_addaddr1: Permission denied Nov 15 04:32:17 volumio---upstairs dhcpcd[567]: eth0: IAID 32:a1:df:5b Nov 15 04:32:17 volumio---upstairs dhcpcd[567]: eth0: adding address fe80::9870:da1d:675:8026 Nov 15 04:32:17 volumio---upstairs dhcpcd[567]: ipv6_addaddr1: Permission denied Nov 15 04:32:17 volumio---upstairs ifplugd[725]: Network Interface Plugging Daemon...start eth0...done. Nov 15 04:32:17 volumio---upstairs systemd[1]: Started LSB: Brings up/down network automatically. Nov 15 04:32:17 volumio---upstairs bluetoothd[732]: Bluetooth daemon 5.50 Nov 15 04:32:17 volumio---upstairs ntpd[727]: ntpd 4.2.8p12@1.3728-o (1): Starting Nov 15 04:32:17 volumio---upstairs ntpd[727]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Nov 15 04:32:17 volumio---upstairs sh[515]: eth0: soliciting an IPv6 router Nov 15 04:32:17 volumio---upstairs dhcpcd[567]: eth0: soliciting an IPv6 router Nov 15 04:32:17 volumio---upstairs ntpd[790]: proto: precision = 2.000 usec (-19) Nov 15 04:32:17 volumio---upstairs systemd[1]: Started Network Time Service. Nov 15 04:32:17 volumio---upstairs bluetoothd[732]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Nov 15 04:32:17 volumio---upstairs systemd[1]: Started Bluetooth service. Nov 15 04:32:17 volumio---upstairs systemd[1]: Reached target Bluetooth. Nov 15 04:32:17 volumio---upstairs bluetoothd[732]: Starting SDP server Nov 15 04:32:17 volumio---upstairs bluetoothd[732]: Excluding (cli) sap Nov 15 04:32:17 volumio---upstairs ntpd[790]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Nov 15 04:32:17 volumio---upstairs ntpd[790]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Nov 15 04:32:17 volumio---upstairs ntpd[790]: Listen and drop on 0 v6wildcard [::]:123 Nov 15 04:32:17 volumio---upstairs ntpd[790]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 15 04:32:17 volumio---upstairs ntpd[790]: Listen normally on 2 lo 127.0.0.1:123 Nov 15 04:32:17 volumio---upstairs ntpd[790]: Listening on routing socket on fd #19 for interface updates Nov 15 04:32:17 volumio---upstairs ntpd[790]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 15 04:32:17 volumio---upstairs ntpd[790]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 15 04:32:17 volumio---upstairs kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Nov 15 04:32:17 volumio---upstairs kernel: Bluetooth: BNEP filters: protocol multicast Nov 15 04:32:17 volumio---upstairs kernel: Bluetooth: BNEP socket layer initialized Nov 15 04:32:17 volumio---upstairs dbus-daemon[626]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=732 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Nov 15 04:32:17 volumio---upstairs kernel: Bluetooth: MGMT ver 1.22 Nov 15 04:32:17 volumio---upstairs bluetoothd[732]: Bluetooth management interface 1.22 initialized Nov 15 04:32:17 volumio---upstairs cpufrequtils[785]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Nov 15 04:32:18 volumio---upstairs bluetoothd[732]: Failed to set privacy: Rejected (0x0b) Nov 15 04:32:18 volumio---upstairs sudo[731]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 15 04:32:18 volumio---upstairs sudo[731]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:18 volumio---upstairs sudo[731]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Nov 15 04:32:18 volumio---upstairs sudo[731]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:18 volumio---upstairs sh[515]: eth0: rebinding lease of 192.168.100.143 Nov 15 04:32:18 volumio---upstairs dhcpcd[567]: eth0: rebinding lease of 192.168.100.143 Nov 15 04:32:18 volumio---upstairs systemd[1]: Started LSB: set CPUFreq kernel parameters. Nov 15 04:32:18 volumio---upstairs systemd[1]: Starting Hostname Service... Nov 15 04:32:18 volumio---upstairs haveged[579]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Nov 15 04:32:18 volumio---upstairs haveged[579]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Nov 15 04:32:18 volumio---upstairs haveged[579]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00257 Nov 15 04:32:18 volumio---upstairs haveged[579]: haveged: fills: 0, generated: 0 Nov 15 04:32:18 volumio---upstairs dbus-daemon[626]: [system] Successfully activated service 'org.freedesktop.hostname1' Nov 15 04:32:18 volumio---upstairs systemd[1]: Started Hostname Service. Nov 15 04:32:18 volumio---upstairs ifplugd(eth0)[783]: Link beat detected. Nov 15 04:32:18 volumio---upstairs ntpd[790]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Nov 15 04:32:18 volumio---upstairs ifplugd(eth0)[783]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Nov 15 04:32:18 volumio---upstairs ifplugd(eth0)[783]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Nov 15 04:32:18 volumio---upstairs nmbd[737]: [2024/11/15 04:32:18.856647, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Nov 15 04:32:18 volumio---upstairs nmbd[737]: started asyncdns process 812 Nov 15 04:32:18 volumio---upstairs nmbd[737]: [2024/11/15 04:32:18.858486, 0] ../lib/util/become_daemon.c:149(daemon_status) Nov 15 04:32:18 volumio---upstairs nmbd[737]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Nov 15 04:32:18 volumio---upstairs nmbd[737]: [2024/11/15 04:32:18.858620, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Nov 15 04:32:18 volumio---upstairs nmbd[737]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Nov 15 04:32:19 volumio---upstairs wireless.js[635]: Cleaning previous... Nov 15 04:32:19 volumio---upstairs sudo[820]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Nov 15 04:32:19 volumio---upstairs sudo[820]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:19 volumio---upstairs sudo[820]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:19 volumio---upstairs sudo[822]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Nov 15 04:32:19 volumio---upstairs sudo[822]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:19 volumio---upstairs sudo[822]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:19 volumio---upstairs wireless.js[635]: Stopped aP Nov 15 04:32:19 volumio---upstairs ntpd[790]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Nov 15 04:32:19 volumio---upstairs wireless.js[635]: Wireless Networking DISABLED, not starting wireless flow Nov 15 04:32:19 volumio---upstairs systemd[1]: systemd-rfkill.service: Succeeded. Nov 15 04:32:19 volumio---upstairs systemd[1]: wireless.service: Succeeded. Nov 15 04:32:19 volumio---upstairs systemd[1]: Started Wireless Services. Nov 15 04:32:19 volumio---upstairs systemd[1]: Started Volumio Backend Module. Nov 15 04:32:19 volumio---upstairs systemd[1]: Started Volumio Cpu Tweaker. Nov 15 04:32:19 volumio---upstairs volumio-cpu-tweak[831]: Setting RT Priority for mpd Nov 15 04:32:19 volumio---upstairs volumio-cpu-tweak[831]: Setting MPD Affinity Nov 15 04:32:20 volumio---upstairs volumio-cpu-tweak[831]: pid 804's current affinity mask: f Nov 15 04:32:20 volumio---upstairs volumio-cpu-tweak[831]: pid 804's new affinity mask: 3 Nov 15 04:32:20 volumio---upstairs volumio-cpu-tweak[831]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Nov 15 04:32:20 volumio---upstairs volumio-cpu-tweak[831]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Nov 15 04:32:20 volumio---upstairs systemd[1]: volumio_cpu_tweak.service: Succeeded. Nov 15 04:32:20 volumio---upstairs mpd[804]: Nov 15 04:32 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 15 04:32:20 volumio---upstairs systemd[1]: Started Music Player Daemon. Nov 15 04:32:20 volumio---upstairs mpd_monitor.sh[643]: MPD restarted due to no mpc output. Nov 15 04:32:20 volumio---upstairs ntpd[790]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Nov 15 04:32:21 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Fetching time from Volumio... Nov 15 04:32:21 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Date not found in response Nov 15 04:32:21 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Retrying in 5 seconds... Nov 15 04:32:21 volumio---upstairs bthelper[664]: Changing power off succeeded Nov 15 04:32:21 volumio---upstairs volumio-remote-updater[639]: [2024-11-15 04:32:21] [connect] Successful connection Nov 15 04:32:21 volumio---upstairs bthelper[664]: [CHG] Controller DC:A6:32:A1:DF:5F Class: 0x0000041c Nov 15 04:32:21 volumio---upstairs bthelper[664]: Changing power on succeeded Nov 15 04:32:21 volumio---upstairs ntpd[790]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Nov 15 04:32:21 volumio---upstairs volumio[830]: info: ------------------------------------------- Nov 15 04:32:21 volumio---upstairs volumio[830]: info: ----- Volumio3 ---- Nov 15 04:32:21 volumio---upstairs volumio[830]: info: ------------------------------------------- Nov 15 04:32:21 volumio---upstairs volumio[830]: info: ----- System startup ---- Nov 15 04:32:21 volumio---upstairs volumio[830]: info: ------------------------------------------- Nov 15 04:32:22 volumio---upstairs volumio[830]: info: MYVOLUMIO Environment detected Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Plugin folders cleanup Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Scanning into folder /volumio/app/plugins/ Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Scanning category audio_interface Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Scanning category miscellanea Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Scanning category music_service Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Scanning category plugins.json Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Scanning category system_controller Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Scanning category user_interface Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Scanning into folder /data/plugins/ Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Scanning category music_service Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Scanning category user_interface Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Plugin folders cleanup completed Nov 15 04:32:22 volumio---upstairs volumio[830]: info: ------------------------------------------- Nov 15 04:32:22 volumio---upstairs volumio[830]: info: ----- Core plugins startup ---- Nov 15 04:32:22 volumio---upstairs volumio[830]: info: ------------------------------------------- Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Loading plugins from folder /volumio/app/plugins/ Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Adding plugin upnp to MyMusic Plugins Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Loading plugins from folder /data/plugins/ Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Loading plugin "system"... Nov 15 04:32:22 volumio---upstairs volumio[830]: info: Loading plugin "appearance"... Nov 15 04:32:23 volumio---upstairs sh[515]: eth0: probing for an IPv4LL address Nov 15 04:32:23 volumio---upstairs dhcpcd[567]: eth0: probing for an IPv4LL address Nov 15 04:32:23 volumio---upstairs sh[515]: eth0: DHCP lease expired Nov 15 04:32:23 volumio---upstairs dhcpcd[567]: eth0: DHCP lease expired Nov 15 04:32:23 volumio---upstairs sh[515]: eth0: soliciting a DHCP lease Nov 15 04:32:23 volumio---upstairs dhcpcd[567]: eth0: soliciting a DHCP lease Nov 15 04:32:23 volumio---upstairs volumio[830]: info: Loading plugin "network"... Nov 15 04:32:23 volumio---upstairs volumio[830]: info: Refreshing Cached IP Addresses Nov 15 04:32:23 volumio---upstairs sudo[885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 15 04:32:23 volumio---upstairs sudo[885]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:23 volumio---upstairs sudo[885]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:23 volumio---upstairs sudo[887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 15 04:32:23 volumio---upstairs volumio[830]: info: Loading plugin "services"... Nov 15 04:32:23 volumio---upstairs sudo[887]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:23 volumio---upstairs volumio[830]: info: Loading plugin "alsa_controller"... Nov 15 04:32:23 volumio---upstairs sudo[887]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:23 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 15 04:32:23 volumio---upstairs volumio[830]: info: Loading plugin "wizard"... Nov 15 04:32:23 volumio---upstairs volumio[830]: info: Loading plugin "networkfs"... Nov 15 04:32:23 volumio---upstairs volumio[830]: info: Starting Udev Watcher for removable devices Nov 15 04:32:23 volumio---upstairs sudo[910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.100.175/jules/music /mnt/NAS/Music Nov 15 04:32:23 volumio---upstairs sudo[910]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:24 volumio---upstairs sudo[912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.100.175/jules/albums /mnt/NAS/Albums Nov 15 04:32:24 volumio---upstairs sudo[912]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Ignoring mount for partition: boot Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Ignoring mount for partition: volumio Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Ignoring mount for partition: volumio_data Nov 15 04:32:24 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "volumio_command_line_client"... Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "upnp"... Nov 15 04:32:24 volumio---upstairs volumio[830]: info: [1731645144041] Starting Upmpd Daemon Nov 15 04:32:24 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "my_music"... Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "mpd"... Nov 15 04:32:24 volumio---upstairs sudo[912]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:24 volumio---upstairs sudo[910]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:24 volumio---upstairs kernel: Key type cifs.spnego registered Nov 15 04:32:24 volumio---upstairs kernel: Key type cifs.idmap registered Nov 15 04:32:24 volumio---upstairs 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. Nov 15 04:32:24 volumio---upstairs kernel: CIFS: Attempting to mount //192.168.100.175/jules/albums Nov 15 04:32:24 volumio---upstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 15 04:32:24 volumio---upstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Nov 15 04:32:24 volumio---upstairs kernel: CIFS: Attempting to mount //192.168.100.175/jules/music Nov 15 04:32:24 volumio---upstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 15 04:32:24 volumio---upstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "upnp_browser"... Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "alarm-clock"... Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "airplay_emulation"... Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Starting Shairport Sync Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "last_100"... Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "webradio"... Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "i2s_dacs"... Nov 15 04:32:24 volumio---upstairs volumio[830]: info: I2S DAC not set, start Auto-detection Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "volumiodiscovery"... Nov 15 04:32:24 volumio---upstairs volumio[830]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 15 04:32:24 volumio---upstairs volumio[830]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 15 04:32:24 volumio---upstairs node[830]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 15 04:32:24 volumio---upstairs volumio[830]: *** WARNING *** For more information see Nov 15 04:32:24 volumio---upstairs volumio[830]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 15 04:32:24 volumio---upstairs volumio[830]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 15 04:32:24 volumio---upstairs volumio[830]: *** WARNING *** For more information see Nov 15 04:32:24 volumio---upstairs node[830]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 15 04:32:24 volumio---upstairs node[830]: *** WARNING *** For more information see Nov 15 04:32:24 volumio---upstairs node[830]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 15 04:32:24 volumio---upstairs node[830]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 15 04:32:24 volumio---upstairs node[830]: *** WARNING *** For more information see Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Discovery: Started advertising with name: Volumio - Upstairs Nov 15 04:32:24 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 15 04:32:24 volumio---upstairs volumio[830]: info: Loading plugin "mixcloud"... Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Loading plugin "outputs"... Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Loading plugin "albumart"... Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Plugin example_plugin is not enabled Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Loading plugin "inputs"... Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Loading plugin "updater_comm"... Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Plugin mpdemulation is not enabled Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Loading plugin "rest_api"... Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Loading plugin "websocket"... Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Starting Socket.io Server version 2.3.0 Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Loading plugin "motherearthradio"... Nov 15 04:32:25 volumio---upstairs volumio[830]: Forking 3 albumart workers Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Applying required configuration parameters for plugin motherearthradio Nov 15 04:32:25 volumio---upstairs volumio[830]: info: [1731645145964] [MotherEarth] API delay: 5 Nov 15 04:32:25 volumio---upstairs volumio[830]: info: Loading plugin "radio_paradise"... Nov 15 04:32:26 volumio---upstairs volumio[830]: Starting albumart workers Nov 15 04:32:26 volumio---upstairs volumio[830]: Starting albumart workers Nov 15 04:32:26 volumio---upstairs volumio[830]: Starting albumart workers Nov 15 04:32:26 volumio---upstairs volumio[830]: info: Applying required configuration parameters for plugin radio_paradise Nov 15 04:32:26 volumio---upstairs volumio[830]: info: [1731645146244] [RadioParadise] API delay: 5 Nov 15 04:32:26 volumio---upstairs volumio[830]: info: Loading plugin "lastfm"... Nov 15 04:32:26 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Fetching time from Volumio... Nov 15 04:32:26 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Date not found in response Nov 15 04:32:26 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Retrying in 5 seconds... Nov 15 04:32:26 volumio---upstairs volumio[830]: info: Loading i18n strings for locale en Nov 15 04:32:26 volumio---upstairs volumio[830]: Updating browse sources language Nov 15 04:32:26 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::initPlayerControls Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: Express server listening on port 3000 Nov 15 04:32:27 volumio---upstairs volumio[830]: [Metrics] WebUI: 5s 761.10ms Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreStateMachine::resetVolumioState Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreStateMachine::getcurrentVolume Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioRetrievevolume Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Volumio Network Manager: Network status updated: 0 Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Cannot mount NAS Albums at system boot, trial number 1 ,retrying in 5 seconds Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds Nov 15 04:32:27 volumio---upstairs volumio[830]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Reloading queue from file Nov 15 04:32:27 volumio---upstairs volumio[830]: info: VolumeController:: Volume=100 Mute =false Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreStateMachine::pushState Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CorePlayQueue::getTrack 0 Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioPushState Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreStateMachine::updateTrackBlock Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CorePlayQueue::getTrackBlock Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioRetrievevolume Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Setting Device type: Raspberry PI Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreStateMachine::setRepeat true single undefined Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreStateMachine::pushState Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CorePlayQueue::getTrack 0 Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioPushState Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreStateMachine::setRandom false Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreStateMachine::pushState Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CorePlayQueue::getTrack 0 Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioPushState Nov 15 04:32:27 volumio---upstairs volumio[830]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Nov 15 04:32:27 volumio---upstairs volumio[830]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Nov 15 04:32:27 volumio---upstairs volumio[830]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Nov 15 04:32:27 volumio---upstairs volumio[830]: info: VolumeController:: Volume=100 Mute =false Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreStateMachine::pushState Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CorePlayQueue::getTrack 0 Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioPushState Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Completed loading Core Plugins Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Preparing to generate the ALSA configuration file Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Asound.conf file unchanged, so no further update is needed Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Output device has changed, restarting MPD Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Output device has changed, restarting Shairport Sync Nov 15 04:32:27 volumio---upstairs sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:27 volumio---upstairs sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:27 volumio---upstairs sudo[1000]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:27 volumio---upstairs sudo[1002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 15 04:32:27 volumio---upstairs sudo[1002]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:27 volumio---upstairs systemd[1]: Stopping Music Player Daemon... Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 15 04:32:27 volumio---upstairs volumio[830]: info: ___________ START PLUGINS ___________ Nov 15 04:32:27 volumio---upstairs volumio[830]: info: ControllerMpd::onStart: Initializing MPD Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Creating MPD Configuration file Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [1731645147572] CoreMusicLibrary::Adding element Media Servers Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:27 volumio---upstairs sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 15 04:32:27 volumio---upstairs sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:27 volumio---upstairs sudo[1011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 15 04:32:27 volumio---upstairs sudo[1011]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:27 volumio---upstairs sudo[1009]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:27 volumio---upstairs systemd[1]: mpd.service: Succeeded. Nov 15 04:32:27 volumio---upstairs systemd[1]: Stopped Music Player Daemon. Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [1731645147662] CoreMusicLibrary::Adding element Last_100 Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [1731645147664] CoreMusicLibrary::Adding element Webradio Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Initializing BBC Radios Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [1731645147722] CoreMusicLibrary::Adding element Mixcloud Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:27 volumio---upstairs volumio[830]: Cannot find translation for source Mixcloud Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [1731645147728] CoreMusicLibrary::Adding element Mother Earth Radio Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:27 volumio---upstairs volumio[830]: Cannot find translation for source Mixcloud Nov 15 04:32:27 volumio---upstairs volumio[830]: Cannot find translation for source Mother Earth Radio Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [1731645147733] CoreMusicLibrary::Adding element Radio Paradise Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:27 volumio---upstairs volumio[830]: Cannot find translation for source Mixcloud Nov 15 04:32:27 volumio---upstairs volumio[830]: Cannot find translation for source Mother Earth Radio Nov 15 04:32:27 volumio---upstairs volumio[830]: Cannot find translation for source Radio Paradise Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [1731645147735] CoreMusicLibrary::Adding element LastFM Nov 15 04:32:27 volumio---upstairs volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:27 volumio---upstairs systemd[1]: Starting Music Player Daemon... Nov 15 04:32:27 volumio---upstairs volumio[830]: Cannot find translation for source Mixcloud Nov 15 04:32:27 volumio---upstairs volumio[830]: Cannot find translation for source Mother Earth Radio Nov 15 04:32:27 volumio---upstairs volumio[830]: Cannot find translation for source Radio Paradise Nov 15 04:32:27 volumio---upstairs volumio[830]: Cannot find translation for source LastFM Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [LastFM] scrobbler initiated! Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [LastFM] extended logging: false Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [LastFM] try scrobble stream/radio plays: true Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [LastFM] Left init routine Nov 15 04:32:27 volumio---upstairs volumio[830]: info: [LastFM] Socket already connected: true Nov 15 04:32:27 volumio---upstairs volumio[830]: info: Volumio Calling Home Nov 15 04:32:27 volumio---upstairs sudo[1020]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 15 04:32:27 volumio---upstairs sudo[1020]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:27 volumio---upstairs sudo[1020]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:27 volumio---upstairs volumio[830]: Unhandled rejection Error: No sockets available, cannot start. Nov 15 04:32:27 volumio---upstairs volumio[830]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Nov 15 04:32:27 volumio---upstairs volumio[830]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Nov 15 04:32:27 volumio---upstairs volumio[830]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Nov 15 04:32:27 volumio---upstairs volumio[830]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Nov 15 04:32:27 volumio---upstairs volumio[830]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Nov 15 04:32:27 volumio---upstairs volumio[830]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Nov 15 04:32:27 volumio---upstairs volumio[830]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Nov 15 04:32:27 volumio---upstairs volumio[830]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Nov 15 04:32:27 volumio---upstairs volumio[830]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Nov 15 04:32:27 volumio---upstairs volumio[830]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Nov 15 04:32:27 volumio---upstairs volumio[830]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Nov 15 04:32:27 volumio---upstairs volumio[830]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Nov 15 04:32:27 volumio---upstairs volumio[830]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Nov 15 04:32:27 volumio---upstairs volumio[830]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Nov 15 04:32:27 volumio---upstairs volumio[830]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Nov 15 04:32:27 volumio---upstairs volumio[830]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Nov 15 04:32:27 volumio---upstairs volumio[830]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 15 04:32:27 volumio---upstairs volumio[830]: Error: getaddrinfo EBUSY ws.audioscrobbler.com Nov 15 04:32:27 volumio---upstairs volumio[830]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) { Nov 15 04:32:27 volumio---upstairs volumio[830]: errno: -16, Nov 15 04:32:27 volumio---upstairs volumio[830]: code: 'EBUSY', Nov 15 04:32:27 volumio---upstairs volumio[830]: syscall: 'getaddrinfo', Nov 15 04:32:27 volumio---upstairs volumio[830]: hostname: 'ws.audioscrobbler.com' Nov 15 04:32:27 volumio---upstairs volumio[830]: } Nov 15 04:32:27 volumio---upstairs volumio[830]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 15 04:32:28 volumio---upstairs sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-15 04:31 Nov 15 04:32:28 volumio---upstairs sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:28 volumio---upstairs sudo[1045]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:28 volumio---upstairs systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 15 04:32:28 volumio---upstairs sudo[1002]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:28 volumio---upstairs sudo[1011]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:28 volumio---upstairs systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 15 04:32:28 volumio---upstairs systemd[1]: Started dynamicswap service. Nov 15 04:32:28 volumio---upstairs systemd[1]: dynamicswap.service: Succeeded. Nov 15 04:32:28 volumio---upstairs mpd[1035]: Nov 15 04:32 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 15 04:32:28 volumio---upstairs systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 15 04:32:28 volumio---upstairs systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Nov 15 04:32:28 volumio---upstairs systemd[1]: Started Music Player Daemon. Nov 15 04:32:28 volumio---upstairs systemd[1]: Started dynamicswap service. Nov 15 04:32:28 volumio---upstairs systemd[1]: Stopped Volumio Backend Module. Nov 15 04:32:28 volumio---upstairs systemd[1]: Started Volumio Backend Module. Nov 15 04:32:28 volumio---upstairs systemd[1]: dynamicswap.service: Succeeded. Nov 15 04:32:28 volumio---upstairs sh[515]: eth0: using IPv4LL address 169.254.133.145 Nov 15 04:32:28 volumio---upstairs sh[515]: eth0: adding route to 169.254.0.0/16 Nov 15 04:32:28 volumio---upstairs sh[515]: eth0: adding default route Nov 15 04:32:28 volumio---upstairs dhcpcd[567]: eth0: using IPv4LL address 169.254.133.145 Nov 15 04:32:28 volumio---upstairs avahi-daemon[636]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.133.145. Nov 15 04:32:28 volumio---upstairs avahi-daemon[636]: New relevant interface eth0.IPv4 for mDNS. Nov 15 04:32:28 volumio---upstairs dhcpcd[567]: eth0: adding route to 169.254.0.0/16 Nov 15 04:32:28 volumio---upstairs avahi-daemon[636]: Registering new address record for 169.254.133.145 on eth0.IPv4. Nov 15 04:32:28 volumio---upstairs dhcpcd[567]: eth0: adding default route Nov 15 04:32:29 volumio---upstairs sh[515]: forked to background, child pid 1084 Nov 15 04:32:29 volumio---upstairs dhcpcd[567]: forked to background, child pid 1084 Nov 15 04:32:29 volumio---upstairs ifplugd(eth0)[783]: client: ifup: interface eth0 already configured Nov 15 04:32:29 volumio---upstairs sh[515]: eth0=eth0 Nov 15 04:32:29 volumio---upstairs ifplugd(eth0)[783]: Program executed successfully. Nov 15 04:32:29 volumio---upstairs volumio[1061]: info: ------------------------------------------- Nov 15 04:32:29 volumio---upstairs volumio[1061]: info: ----- Volumio3 ---- Nov 15 04:32:29 volumio---upstairs volumio[1061]: info: ------------------------------------------- Nov 15 04:32:29 volumio---upstairs volumio[1061]: info: ----- System startup ---- Nov 15 04:32:29 volumio---upstairs volumio[1061]: info: ------------------------------------------- Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: MYVOLUMIO Environment detected Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Plugin folders cleanup Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Scanning into folder /volumio/app/plugins/ Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Scanning category audio_interface Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Scanning category miscellanea Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Scanning category music_service Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Scanning category plugins.json Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Scanning category system_controller Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Scanning category user_interface Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Scanning into folder /data/plugins/ Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Scanning category music_service Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Scanning category user_interface Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Plugin folders cleanup completed Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: ------------------------------------------- Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: ----- Core plugins startup ---- Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: ------------------------------------------- Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugins from folder /volumio/app/plugins/ Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Adding plugin upnp to MyMusic Plugins Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugins from folder /data/plugins/ Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugin "system"... Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugin "appearance"... Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugin "network"... Nov 15 04:32:30 volumio---upstairs ntpd[790]: Listen normally on 3 eth0 169.254.133.145:123 Nov 15 04:32:30 volumio---upstairs ntpd[790]: new interface(s) found: waking up resolver Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Refreshing Cached IP Addresses Nov 15 04:32:30 volumio---upstairs sudo[1127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 15 04:32:30 volumio---upstairs sudo[1127]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:30 volumio---upstairs sudo[1127]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:30 volumio---upstairs sudo[1129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 15 04:32:30 volumio---upstairs sudo[1129]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugin "services"... Nov 15 04:32:30 volumio---upstairs sudo[1129]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugin "alsa_controller"... Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugin "wizard"... Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugin "networkfs"... Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Starting Udev Watcher for removable devices Nov 15 04:32:30 volumio---upstairs sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.100.175/jules/music /mnt/NAS/Music Nov 15 04:32:30 volumio---upstairs sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:30 volumio---upstairs sudo[1154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.100.175/jules/albums /mnt/NAS/Albums Nov 15 04:32:30 volumio---upstairs sudo[1154]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:30 volumio---upstairs kernel: CIFS: Attempting to mount //192.168.100.175/jules/music Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Ignoring mount for partition: boot Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Ignoring mount for partition: volumio Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Ignoring mount for partition: volumio_data Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugin "volumio_command_line_client"... Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugin "upnp"... Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: [1731645150947] Starting Upmpd Daemon Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugin "my_music"... Nov 15 04:32:30 volumio---upstairs volumio[1061]: info: Loading plugin "mpd"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "upnp_browser"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "alarm-clock"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "airplay_emulation"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Starting Shairport Sync Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "last_100"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "webradio"... Nov 15 04:32:31 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Fetching time from Volumio... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "i2s_dacs"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: I2S DAC not set, start Auto-detection Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "volumiodiscovery"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 15 04:32:31 volumio---upstairs volumio[1061]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 15 04:32:31 volumio---upstairs node[1061]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 15 04:32:31 volumio---upstairs volumio[1061]: *** WARNING *** For more information see Nov 15 04:32:31 volumio---upstairs volumio[1061]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 15 04:32:31 volumio---upstairs volumio[1061]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 15 04:32:31 volumio---upstairs volumio[1061]: *** WARNING *** For more information see Nov 15 04:32:31 volumio---upstairs node[1061]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 15 04:32:31 volumio---upstairs node[1061]: *** WARNING *** For more information see Nov 15 04:32:31 volumio---upstairs node[1061]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 15 04:32:31 volumio---upstairs node[1061]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 15 04:32:31 volumio---upstairs node[1061]: *** WARNING *** For more information see Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Discovery: Started advertising with name: Volumio - Upstairs Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "mixcloud"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "outputs"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "albumart"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Plugin example_plugin is not enabled Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "inputs"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "updater_comm"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Plugin mpdemulation is not enabled Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "rest_api"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "websocket"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Starting Socket.io Server version 2.3.0 Nov 15 04:32:31 volumio---upstairs volumio[1061]: info: Loading plugin "motherearthradio"... Nov 15 04:32:31 volumio---upstairs volumio[1061]: Forking 3 albumart workers Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: Applying required configuration parameters for plugin motherearthradio Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: [1731645152051] [MotherEarth] API delay: 5 Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: Loading plugin "radio_paradise"... Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: Applying required configuration parameters for plugin radio_paradise Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: [1731645152200] [RadioParadise] API delay: 5 Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: Loading plugin "lastfm"... Nov 15 04:32:32 volumio---upstairs volumio[1061]: Starting albumart workers Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: Loading i18n strings for locale en Nov 15 04:32:32 volumio---upstairs volumio[1061]: Starting albumart workers Nov 15 04:32:32 volumio---upstairs volumio[1061]: Updating browse sources language Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:32 volumio---upstairs volumio[1061]: Starting albumart workers Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::initPlayerControls Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 04:32:32 volumio---upstairs volumio[1061]: Express server listening on port 3000 Nov 15 04:32:32 volumio---upstairs volumio[1061]: [Metrics] WebUI: 3s 269.79ms Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreStateMachine::resetVolumioState Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreStateMachine::getcurrentVolume Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioRetrievevolume Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:32 volumio---upstairs volumio[1061]: info: Volumio Network Manager: Network status updated: 1 Nov 15 04:32:33 volumio---upstairs volumio[1061]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: Reloading queue from file Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: VolumeController:: Volume=100 Mute =false Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreStateMachine::pushState Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CorePlayQueue::getTrack 0 Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioPushState Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreStateMachine::updateTrackBlock Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CorePlayQueue::getTrackBlock Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioRetrievevolume Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: Setting Device type: Raspberry PI Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreStateMachine::setRepeat true single undefined Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreStateMachine::pushState Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CorePlayQueue::getTrack 0 Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioPushState Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreStateMachine::setRandom false Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreStateMachine::pushState Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CorePlayQueue::getTrack 0 Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioPushState Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: VolumeController:: Volume=100 Mute =false Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreStateMachine::pushState Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CorePlayQueue::getTrack 0 Nov 15 04:32:33 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioPushState Nov 15 04:32:33 volumio---upstairs nmbd[737]: [2024/11/15 04:32:33.861361, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 15 04:32:33 volumio---upstairs nmbd[737]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 15 04:32:33 volumio---upstairs systemd[1]: Started Samba NMB Daemon. Nov 15 04:32:33 volumio---upstairs systemd[1]: Starting Samba Winbind Daemon... Nov 15 04:32:33 volumio---upstairs volumio-remote-updater[639]: [2024-11-15 04:32:33] [connect] Successful connection Nov 15 04:32:33 volumio---upstairs volumio-remote-updater[639]: [2024-11-15 04:32:33] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1731645153 101 Nov 15 04:32:33 volumio---upstairs volumio[1061]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Nov 15 04:32:34 volumio---upstairs winbindd[1231]: [2024/11/15 04:32:34.079640, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Nov 15 04:32:34 volumio---upstairs winbindd[1231]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 15 04:32:34 volumio---upstairs winbindd[1231]: [2024/11/15 04:32:34.104547, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 15 04:32:34 volumio---upstairs systemd[1]: Started Samba Winbind Daemon. Nov 15 04:32:34 volumio---upstairs winbindd[1231]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 15 04:32:34 volumio---upstairs systemd[1]: Starting Samba SMB Daemon... Nov 15 04:32:34 volumio---upstairs winbindd[1231]: [2024/11/15 04:32:34.477764, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Nov 15 04:32:34 volumio---upstairs winbindd[1231]: res_names->count = 3, expected 4 Nov 15 04:32:34 volumio---upstairs smbd[1236]: [2024/11/15 04:32:34.493901, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 15 04:32:34 volumio---upstairs smbd[1236]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 15 04:32:34 volumio---upstairs systemd[1]: Started Samba SMB Daemon. Nov 15 04:32:38 volumio---upstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -112 Nov 15 04:32:38 volumio---upstairs kernel: CIFS: Attempting to mount //192.168.100.175/jules/albums Nov 15 04:32:38 volumio---upstairs sudo[1152]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:38 volumio---upstairs volumio[1061]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds Nov 15 04:32:39 volumio---upstairs sudo[1154]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Completed loading Core Plugins Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Preparing to generate the ALSA configuration file Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Asound.conf file unchanged, so no further update is needed Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Output device has changed, restarting MPD Nov 15 04:32:39 volumio---upstairs sudo[1258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 15 04:32:39 volumio---upstairs sudo[1258]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Output device has changed, restarting Shairport Sync Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:39 volumio---upstairs sudo[1258]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:39 volumio---upstairs sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 15 04:32:39 volumio---upstairs sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:39 volumio---upstairs systemd[1]: Stopping Music Player Daemon... Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: ___________ START PLUGINS ___________ Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: ControllerMpd::onStart: Initializing MPD Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Creating MPD Configuration file Nov 15 04:32:39 volumio---upstairs systemd[1]: mpd.service: Succeeded. Nov 15 04:32:39 volumio---upstairs systemd[1]: Stopped Music Player Daemon. Nov 15 04:32:39 volumio---upstairs sudo[1268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 15 04:32:39 volumio---upstairs sudo[1268]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [1731645159127] CoreMusicLibrary::Adding element Media Servers Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:39 volumio---upstairs sudo[1268]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:39 volumio---upstairs systemd[1]: Starting Music Player Daemon... Nov 15 04:32:39 volumio---upstairs sudo[1270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 15 04:32:39 volumio---upstairs sudo[1270]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:39 volumio---upstairs systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 15 04:32:39 volumio---upstairs systemd[1]: mpd.service: Succeeded. Nov 15 04:32:39 volumio---upstairs systemd[1]: Stopped Music Player Daemon. Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:39 volumio---upstairs systemd[1]: Starting Music Player Daemon... Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [1731645159216] CoreMusicLibrary::Adding element Last_100 Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [1731645159218] CoreMusicLibrary::Adding element Webradio Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Initializing BBC Radios Nov 15 04:32:39 volumio---upstairs sudo[1276]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 15 04:32:39 volumio---upstairs sudo[1276]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:39 volumio---upstairs sudo[1276]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [1731645159282] CoreMusicLibrary::Adding element Mixcloud Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:39 volumio---upstairs volumio[1061]: Cannot find translation for source Mixcloud Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [1731645159287] CoreMusicLibrary::Adding element Mother Earth Radio Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:39 volumio---upstairs volumio[1061]: Cannot find translation for source Mixcloud Nov 15 04:32:39 volumio---upstairs volumio[1061]: Cannot find translation for source Mother Earth Radio Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [1731645159290] CoreMusicLibrary::Adding element Radio Paradise Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:39 volumio---upstairs volumio[1061]: Cannot find translation for source Mixcloud Nov 15 04:32:39 volumio---upstairs volumio[1061]: Cannot find translation for source Mother Earth Radio Nov 15 04:32:39 volumio---upstairs volumio[1061]: Cannot find translation for source Radio Paradise Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [1731645159293] CoreMusicLibrary::Adding element LastFM Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 15 04:32:39 volumio---upstairs volumio[1061]: Cannot find translation for source Mixcloud Nov 15 04:32:39 volumio---upstairs volumio[1061]: Cannot find translation for source Mother Earth Radio Nov 15 04:32:39 volumio---upstairs volumio[1061]: Cannot find translation for source Radio Paradise Nov 15 04:32:39 volumio---upstairs volumio[1061]: Cannot find translation for source LastFM Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [LastFM] scrobbler initiated! Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [LastFM] extended logging: false Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [LastFM] try scrobble stream/radio plays: true Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [LastFM] Left init routine Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: [LastFM] Socket already connected: true Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Volumio Calling Home Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: MPD Permissions set Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: MPD Permissions set Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Starting Shairport Sync Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Starting Shairport Sync Nov 15 04:32:39 volumio---upstairs sudo[1304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Starting Shairport Sync Nov 15 04:32:39 volumio---upstairs sudo[1304]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:39 volumio---upstairs sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 15 04:32:39 volumio---upstairs sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:39 volumio---upstairs systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 15 04:32:39 volumio---upstairs systemd[1]: shairport-sync.service: Succeeded. Nov 15 04:32:39 volumio---upstairs systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 15 04:32:39 volumio---upstairs sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 15 04:32:39 volumio---upstairs sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:39 volumio---upstairs systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 15 04:32:39 volumio---upstairs sudo[1304]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Shairport-Sync Started Nov 15 04:32:39 volumio---upstairs volumio[1061]: Error adding Membership: Error: addMembership EINVAL Nov 15 04:32:39 volumio---upstairs systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 15 04:32:39 volumio---upstairs systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 15 04:32:39 volumio---upstairs systemd[1]: shairport-sync.service: Succeeded. Nov 15 04:32:39 volumio---upstairs systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 15 04:32:39 volumio---upstairs systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 15 04:32:39 volumio---upstairs sudo[1309]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:39 volumio---upstairs sudo[1306]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:39 volumio---upstairs volumio[1061]: info: Shairport-Sync Started Nov 15 04:32:39 volumio---upstairs mpd[1288]: Nov 15 04:32 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 15 04:32:40 volumio---upstairs systemd[1]: Started Music Player Daemon. Nov 15 04:32:40 volumio---upstairs sudo[1270]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:40 volumio---upstairs sudo[1260]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:40 volumio---upstairs volumio[1061]: info: Completed starting Core Plugins Nov 15 04:32:40 volumio---upstairs volumio[1061]: info: ------------------------------------------- Nov 15 04:32:40 volumio---upstairs volumio[1061]: info: ----- MyVolumio plugins startup ---- Nov 15 04:32:40 volumio---upstairs volumio[1061]: info: ------------------------------------------- Nov 15 04:32:40 volumio---upstairs volumio[1061]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 15 04:32:40 volumio---upstairs volumio[1061]: error: MPD error: The expression evaluated to a falsy value: Nov 15 04:32:40 volumio---upstairs volumio[1061]: assert.ok(self.idling) Nov 15 04:32:40 volumio---upstairs volumio[1061]: error: The expression evaluated to a falsy value: Nov 15 04:32:40 volumio---upstairs volumio[1061]: assert.ok(self.idling) Nov 15 04:32:40 volumio---upstairs volumio[1061]: info: MPD running with PID1288 Nov 15 04:32:40 volumio---upstairs volumio[1061]: ,establishing connection Nov 15 04:32:40 volumio---upstairs volumio[1061]: error: updateQueue error: null Nov 15 04:32:40 volumio---upstairs volumio[1061]: error: updateQueue error: null Nov 15 04:32:40 volumio---upstairs sudo[1338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 15 04:32:40 volumio---upstairs sudo[1338]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:40 volumio---upstairs sudo[1338]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:40 volumio---upstairs sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 15 04:32:40 volumio---upstairs sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:40 volumio---upstairs sudo[1340]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:41 volumio---upstairs sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 15 04:32:41 volumio---upstairs sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:41 volumio---upstairs systemd[1]: Started UPnP Renderer front-end to MPD. Nov 15 04:32:41 volumio---upstairs sudo[1344]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:41 volumio---upstairs volumio[1061]: info: Upmpdcli Daemon Started Nov 15 04:32:41 volumio---upstairs volumio[1346]: Generating RSA private key, 4096 bit long modulus (2 primes) Nov 15 04:32:43 volumio---upstairs volumio[1346]: ...................++++ Nov 15 04:32:43 volumio---upstairs sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.100.175/jules/music /mnt/NAS/Music Nov 15 04:32:43 volumio---upstairs sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 04:32:43 volumio---upstairs kernel: CIFS: Attempting to mount //192.168.100.175/jules/music Nov 15 04:32:43 volumio---upstairs sudo[1363]: pam_unix(sudo:session): session closed for user root Nov 15 04:32:44 volumio---upstairs systemd[1]: systemd-fsckd.service: Succeeded. Nov 15 04:32:45 volumio---upstairs volumio[1061]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Nov 15 04:32:45 volumio---upstairs volumio[1346]: .........................++++ Nov 15 04:32:45 volumio---upstairs volumio[1346]: e is 65537 (0x010001) Nov 15 04:32:45 volumio---upstairs volumio[1346]: writing RSA key Nov 15 04:32:48 volumio---upstairs systemd[1]: systemd-hostnamed.service: Succeeded. Nov 15 04:32:51 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Date not found in response Nov 15 04:32:51 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Retrying in 5 seconds... Nov 15 04:32:56 volumio---upstairs volumio-time-update[599]: volumio-time-update-util: Fetching time from Volumio... Nov 15 04:32:57 volumio---upstairs dhcpcd[1084]: eth0: offered 192.168.100.142 from 192.168.100.1 Nov 15 04:32:57 volumio---upstairs dhcpcd[1084]: eth0: probing address 192.168.100.142/24 Nov 15 04:32:59 volumio---upstairs volumio[1061]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 15 04:32:59 volumio---upstairs volumio[1061]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com Nov 15 04:32:59 volumio---upstairs volumio[1061]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) { Nov 15 04:32:59 volumio---upstairs volumio[1061]: errno: -3007, Nov 15 04:32:59 volumio---upstairs volumio[1061]: code: 'ENOTFOUND', Nov 15 04:32:59 volumio---upstairs volumio[1061]: syscall: 'getaddrinfo', Nov 15 04:32:59 volumio---upstairs volumio[1061]: hostname: 'ws.audioscrobbler.com' Nov 15 04:32:59 volumio---upstairs volumio[1061]: } Nov 15 04:32:59 volumio---upstairs volumio[1061]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 15 04:32:59 volumio---upstairs sudo[1419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-15 04:31 Nov 15 04:32:59 volumio---upstairs sudo[1419]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"