-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sun 2024-03-10 15:21:22 UTC. -- Mar 10 15:20:12 volumiolounge kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Mar 10 15:20:12 volumiolounge kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] Mar 10 15:20:12 volumiolounge kernel: pcieport 0000:00:00.0: enabling device (0140 -> 0142) Mar 10 15:20:12 volumiolounge kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 62 Mar 10 15:20:12 volumiolounge kernel: bcm2708_fb soc:fb: FB found 1 display(s) Mar 10 15:20:12 volumiolounge kernel: Console: switching to colour frame buffer device 80x30 Mar 10 15:20:12 volumiolounge kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480 Mar 10 15:20:12 volumiolounge kernel: iproc-rng200 fe104000.rng: hwrng registered Mar 10 15:20:12 volumiolounge kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Mar 10 15:20:12 volumiolounge kernel: gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000 Mar 10 15:20:12 volumiolounge kernel: brd: module loaded Mar 10 15:20:12 volumiolounge kernel: loop: module loaded Mar 10 15:20:12 volumiolounge kernel: Loading iSCSI transport class v2.0-870. Mar 10 15:20:12 volumiolounge kernel: libphy: Fixed MDIO Bus: probed Mar 10 15:20:12 volumiolounge kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 Mar 10 15:20:12 volumiolounge kernel: libphy: bcmgenet MII bus: probed Mar 10 15:20:12 volumiolounge kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus Mar 10 15:20:12 volumiolounge kernel: usbcore: registered new interface driver r8152 Mar 10 15:20:12 volumiolounge kernel: usbcore: registered new interface driver lan78xx Mar 10 15:20:12 volumiolounge kernel: usbcore: registered new interface driver smsc95xx Mar 10 15:20:12 volumiolounge kernel: xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142) Mar 10 15:20:12 volumiolounge kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Mar 10 15:20:12 volumiolounge kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 Mar 10 15:20:12 volumiolounge kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x00000e0000000890 Mar 10 15:20:12 volumiolounge kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10 Mar 10 15:20:12 volumiolounge kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 10 15:20:12 volumiolounge kernel: usb usb1: Product: xHCI Host Controller Mar 10 15:20:12 volumiolounge kernel: usb usb1: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd Mar 10 15:20:12 volumiolounge kernel: usb usb1: SerialNumber: 0000:01:00.0 Mar 10 15:20:12 volumiolounge kernel: hub 1-0:1.0: USB hub found Mar 10 15:20:12 volumiolounge kernel: hub 1-0:1.0: 1 port detected Mar 10 15:20:12 volumiolounge kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Mar 10 15:20:12 volumiolounge kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 Mar 10 15:20:12 volumiolounge kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed Mar 10 15:20:12 volumiolounge kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10 Mar 10 15:20:12 volumiolounge kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 10 15:20:12 volumiolounge kernel: usb usb2: Product: xHCI Host Controller Mar 10 15:20:12 volumiolounge kernel: usb usb2: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd Mar 10 15:20:12 volumiolounge kernel: usb usb2: SerialNumber: 0000:01:00.0 Mar 10 15:20:12 volumiolounge kernel: hub 2-0:1.0: USB hub found Mar 10 15:20:12 volumiolounge kernel: hub 2-0:1.0: 4 ports detected Mar 10 15:20:12 volumiolounge kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Mar 10 15:20:12 volumiolounge kernel: dwc_otg: FIQ enabled Mar 10 15:20:12 volumiolounge kernel: dwc_otg: NAK holdoff enabled Mar 10 15:20:12 volumiolounge kernel: dwc_otg: FIQ split-transaction FSM enabled Mar 10 15:20:12 volumiolounge kernel: Module dwc_common_port init Mar 10 15:20:12 volumiolounge kernel: usbcore: registered new interface driver uas Mar 10 15:20:12 volumiolounge kernel: usbcore: registered new interface driver usb-storage Mar 10 15:20:12 volumiolounge kernel: mousedev: PS/2 mouse device common for all mice Mar 10 15:20:12 volumiolounge kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Mar 10 15:20:12 volumiolounge kernel: sdhci: Secure Digital Host Controller Interface driver Mar 10 15:20:12 volumiolounge kernel: sdhci: Copyright(c) Pierre Ossman Mar 10 15:20:12 volumiolounge kernel: mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe Mar 10 15:20:12 volumiolounge kernel: sdhci-pltfm: SDHCI platform and OF driver helper Mar 10 15:20:12 volumiolounge kernel: ledtrig-cpu: registered to indicate activity on CPUs Mar 10 15:20:12 volumiolounge kernel: hid: raw HID events driver (C) Jiri Kosina Mar 10 15:20:12 volumiolounge kernel: usbcore: registered new interface driver usbhid Mar 10 15:20:12 volumiolounge kernel: usbhid: USB HID core driver Mar 10 15:20:12 volumiolounge kernel: Initializing XFRM netlink socket Mar 10 15:20:12 volumiolounge kernel: NET: Registered protocol family 17 Mar 10 15:20:12 volumiolounge kernel: Key type dns_resolver registered Mar 10 15:20:12 volumiolounge kernel: Registering SWP/SWPB emulation handler Mar 10 15:20:12 volumiolounge kernel: registered taskstats version 1 Mar 10 15:20:12 volumiolounge kernel: Loading compiled-in X.509 certificates Mar 10 15:20:12 volumiolounge kernel: Key type ._fscrypt registered Mar 10 15:20:12 volumiolounge kernel: Key type .fscrypt registered Mar 10 15:20:12 volumiolounge kernel: Key type fscrypt-provisioning registered Mar 10 15:20:12 volumiolounge kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Mar 10 15:20:12 volumiolounge kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Mar 10 15:20:12 volumiolounge kernel: fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2 Mar 10 15:20:12 volumiolounge kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Mar 10 15:20:12 volumiolounge kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Mar 10 15:20:12 volumiolounge kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Mar 10 15:20:12 volumiolounge kernel: of_cfs_init Mar 10 15:20:12 volumiolounge kernel: of_cfs_init: OK Mar 10 15:20:12 volumiolounge kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes) Mar 10 15:20:12 volumiolounge kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Mar 10 15:20:12 volumiolounge kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Mar 10 15:20:12 volumiolounge kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes) Mar 10 15:20:12 volumiolounge kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Mar 10 15:20:12 volumiolounge kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Mar 10 15:20:12 volumiolounge kernel: Freeing unused kernel memory: 2048K Mar 10 15:20:12 volumiolounge kernel: Run /init as init process Mar 10 15:20:12 volumiolounge kernel: with arguments: Mar 10 15:20:12 volumiolounge kernel: /init Mar 10 15:20:12 volumiolounge kernel: splash Mar 10 15:20:12 volumiolounge kernel: with environment: Mar 10 15:20:12 volumiolounge kernel: HOME=/ Mar 10 15:20:12 volumiolounge kernel: TERM=linux Mar 10 15:20:12 volumiolounge kernel: imgpart=/dev/mmcblk0p2 Mar 10 15:20:12 volumiolounge kernel: imgfile=/volumio_current.sqsh Mar 10 15:20:12 volumiolounge kernel: bootdelay=5 Mar 10 15:20:12 volumiolounge kernel: mmc1: new high speed SDIO card at address 0001 Mar 10 15:20:12 volumiolounge kernel: mmc0: new ultra high speed DDR50 SDXC card at address aaaa Mar 10 15:20:12 volumiolounge kernel: mmcblk0: mmc0:aaaa SC64G 59.5 GiB Mar 10 15:20:12 volumiolounge kernel: mmcblk0: p1 p2 p3 Mar 10 15:20:12 volumiolounge kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Mar 10 15:20:12 volumiolounge initramfs: Booting Volumio for BCM2711 Mar 10 15:20:12 volumiolounge initramfs: This script mounts rootfs RO with an overlay RW layer. Mar 10 15:20:12 volumiolounge kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 10 15:20:12 volumiolounge initramfs: IMGPART=/dev/mmcblk0p2 Mar 10 15:20:12 volumiolounge initramfs: IMGFILE=/volumio_current.sqsh Mar 10 15:20:12 volumiolounge initramfs: Boot delay (except first time) will be 5 seconds Mar 10 15:20:12 volumiolounge initramfs: /dev/mmcblk0p2: Mar 10 15:20:12 volumiolounge kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Mar 10 15:20:12 volumiolounge kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Mar 10 15:20:12 volumiolounge kernel: usb 1-1: Product: USB2.0 Hub Mar 10 15:20:12 volumiolounge kernel: hub 1-1:1.0: USB hub found Mar 10 15:20:12 volumiolounge kernel: hub 1-1:1.0: 4 ports detected Mar 10 15:20:12 volumiolounge kernel: EXT4-fs (mmcblk0p2): recovery complete Mar 10 15:20:12 volumiolounge kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Mar 10 15:20:12 volumiolounge initramfs: Doing a 5 second delay here to give kernel load a headstart Mar 10 15:20:12 volumiolounge initramfs: Checking for USB updates Mar 10 15:20:12 volumiolounge initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Mar 10 15:20:12 volumiolounge kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Mar 10 15:20:12 volumiolounge kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Mar 10 15:20:12 volumiolounge kernel: EXT4-fs (mmcblk0p3): recovery complete Mar 10 15:20:12 volumiolounge kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Mar 10 15:20:12 volumiolounge initramfs: With Option: Mar 10 15:20:12 volumiolounge initramfs: VOLUMIO_VERSION="3.512" Mar 10 15:20:12 volumiolounge initramfs: Finish initramfs, continue booting Volumio Mar 10 15:20:12 volumiolounge systemd[1]: System time before build time, advancing clock. Mar 10 15:20:12 volumiolounge kernel: NET: Registered protocol family 10 Mar 10 15:20:12 volumiolounge kernel: Segment Routing with IPv6 Mar 10 15:20:12 volumiolounge systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Mar 10 15:20:12 volumiolounge systemd[1]: Detected architecture arm. Mar 10 15:20:12 volumiolounge systemd[1]: Set hostname to . Mar 10 15:20:12 volumiolounge systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 10 15:20:12 volumiolounge kernel: random: systemd: uninitialized urandom read (16 bytes read) Mar 10 15:20:12 volumiolounge kernel: random: systemd: uninitialized urandom read (16 bytes read) Mar 10 15:20:12 volumiolounge kernel: random: systemd: uninitialized urandom read (16 bytes read) Mar 10 15:20:12 volumiolounge systemd[1]: Created slice system-getty.slice. Mar 10 15:20:12 volumiolounge systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Mar 10 15:20:12 volumiolounge systemd[1]: Listening on fsck to fsckd communication Socket. Mar 10 15:20:12 volumiolounge systemd[1]: Listening on Journal Socket. Mar 10 15:20:12 volumiolounge systemd[1]: Mounting Kernel Debug File System... Mar 10 15:20:12 volumiolounge systemd[1]: Starting Create list of required static device nodes for the current kernel... Mar 10 15:20:12 volumiolounge kernel: i2c /dev entries driver Mar 10 15:20:12 volumiolounge systemd-journald[204]: Journal started Mar 10 15:20:12 volumiolounge systemd-journald[204]: Runtime journal (/run/log/journal/03837a839dbf02e377dd5ba761c0a77e) is 7.5M, max 30.0M, 22.5M free. Mar 10 15:20:12 volumiolounge systemd-modules-load[192]: Inserted module 'i2c_dev' Mar 10 15:20:12 volumiolounge fake-hwclock[205]: Sun Mar 10 15:20:12 UTC 2024 Mar 10 15:20:12 volumiolounge systemd[1]: dynamicswap.service: Succeeded. Mar 10 15:20:12 volumiolounge systemd[1]: Started Create Static Device Nodes in /dev. Mar 10 15:20:12 volumiolounge systemd[1]: Starting udev Kernel Device Manager... Mar 10 15:20:12 volumiolounge systemd[1]: Reached target Local File Systems (Pre). Mar 10 15:20:12 volumiolounge systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Mar 10 15:20:12 volumiolounge systemd[1]: Mounting /tmp... Mar 10 15:20:12 volumiolounge systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Mar 10 15:20:12 volumiolounge systemd[1]: Mounting /var/log... Mar 10 15:20:12 volumiolounge systemd[1]: Mounting /var/spool/cups... Mar 10 15:20:12 volumiolounge systemd[1]: Mounted /tmp. Mar 10 15:20:12 volumiolounge systemd-udevd[222]: Network interface NamePolicy= disabled on kernel command line, ignoring. Mar 10 15:20:12 volumiolounge systemd[1]: Mounted /var/log. Mar 10 15:20:12 volumiolounge systemd[1]: Mounted /var/spool/cups. Mar 10 15:20:12 volumiolounge systemd[1]: Mounting /var/spool/cups/tmp... Mar 10 15:20:12 volumiolounge systemd[1]: Starting Flush Journal to Persistent Storage... Mar 10 15:20:12 volumiolounge systemd[1]: Mounted /var/spool/cups/tmp. Mar 10 15:20:12 volumiolounge systemd[1]: Started udev Kernel Device Manager. Mar 10 15:20:12 volumiolounge systemd-journald[204]: Runtime journal (/run/log/journal/03837a839dbf02e377dd5ba761c0a77e) is 7.5M, max 30.0M, 22.5M free. Mar 10 15:20:12 volumiolounge systemd[1]: Started Flush Journal to Persistent Storage. Mar 10 15:20:12 volumiolounge systemd[1]: Started udev Coldplug all Devices. Mar 10 15:20:12 volumiolounge systemd[1]: Starting Show Plymouth Boot Screen... Mar 10 15:20:12 volumiolounge systemd[1]: Starting Helper to synchronize boot up for ifupdown... Mar 10 15:20:12 volumiolounge systemd[1]: Received SIGRTMIN+20 from PID 261 (plymouthd). Mar 10 15:20:12 volumiolounge systemd[1]: Started Helper to synchronize boot up for ifupdown. Mar 10 15:20:12 volumiolounge systemd[1]: Started Show Plymouth Boot Screen. Mar 10 15:20:12 volumiolounge systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 10 15:20:12 volumiolounge systemd[1]: Reached target Local Encrypted Volumes. Mar 10 15:20:12 volumiolounge systemd[1]: Reached target Paths. Mar 10 15:20:12 volumiolounge systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Mar 10 15:20:12 volumiolounge kernel: rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000 Mar 10 15:20:12 volumiolounge kernel: rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000 Mar 10 15:20:12 volumiolounge kernel: rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000 Mar 10 15:20:12 volumiolounge kernel: rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000 Mar 10 15:20:12 volumiolounge systemd-udevd[229]: Using default interface naming scheme 'v240'. Mar 10 15:20:12 volumiolounge kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Mar 10 15:20:12 volumiolounge kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Mar 10 15:20:12 volumiolounge kernel: [vc_sm_connected_init]: start Mar 10 15:20:12 volumiolounge kernel: [vc_sm_connected_init]: installed successfully Mar 10 15:20:13 volumiolounge systemd-udevd[240]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 10 15:20:13 volumiolounge kernel: mc: Linux media interface: v0.10 Mar 10 15:20:13 volumiolounge kernel: videodev: Linux video capture interface: v2.00 Mar 10 15:20:13 volumiolounge kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Mar 10 15:20:13 volumiolounge systemd-udevd[229]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 10 15:20:13 volumiolounge kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Mar 10 15:20:13 volumiolounge kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Mar 10 15:20:13 volumiolounge kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Mar 10 15:20:13 volumiolounge kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Mar 10 15:20:13 volumiolounge kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Mar 10 15:20:13 volumiolounge kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Mar 10 15:20:13 volumiolounge kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Mar 10 15:20:13 volumiolounge kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Mar 10 15:20:13 volumiolounge kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Mar 10 15:20:13 volumiolounge kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Mar 10 15:20:13 volumiolounge kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Mar 10 15:20:13 volumiolounge kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Mar 10 15:20:13 volumiolounge kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Mar 10 15:20:13 volumiolounge kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Mar 10 15:20:13 volumiolounge kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Mar 10 15:20:14 volumiolounge kernel: wm8804 1-003b: revision E Mar 10 15:20:14 volumiolounge kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Mar 10 15:20:15 volumiolounge kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Mar 10 15:20:15 volumiolounge kernel: cfg80211: loaded regulatory.db is malformed or signature is missing/invalid Mar 10 15:20:15 volumiolounge systemd[1]: Found device /dev/mmcblk0p1. Mar 10 15:20:15 volumiolounge kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Mar 10 15:20:15 volumiolounge kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Mar 10 15:20:15 volumiolounge kernel: usbcore: registered new interface driver brcmfmac Mar 10 15:20:15 volumiolounge systemd[1]: Condition check resulted in FUSE Control File System being skipped. Mar 10 15:20:15 volumiolounge systemd[1]: Condition check resulted in Huge Pages File System being skipped. Mar 10 15:20:15 volumiolounge systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Mar 10 15:20:15 volumiolounge systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Mar 10 15:20:15 volumiolounge systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 10 15:20:15 volumiolounge systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Mar 10 15:20:15 volumiolounge systemd[1]: Starting File System Check on /dev/mmcblk0p1... Mar 10 15:20:16 volumiolounge systemd[1]: Started File System Check Daemon to report status. Mar 10 15:20:16 volumiolounge systemd[1]: Found device /sys/subsystem/net/devices/eth0. Mar 10 15:20:16 volumiolounge kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Mar 10 15:20:16 volumiolounge 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 Mar 10 15:20:16 volumiolounge systemd[1]: Starting Load/Save RF Kill Switch Status... Mar 10 15:20:16 volumiolounge systemd-fsck[387]: fsck.fat 4.1 (2017-01-24) Mar 10 15:20:16 volumiolounge systemd-fsck[387]: 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Mar 10 15:20:16 volumiolounge systemd-fsck[387]: Automatically removing dirty bit. Mar 10 15:20:16 volumiolounge systemd-fsck[387]: Performing changes. Mar 10 15:20:16 volumiolounge systemd-fsck[387]: /dev/mmcblk0p1: 305 files, 109534/123044 clusters Mar 10 15:20:16 volumiolounge systemd[1]: Started File System Check on /dev/mmcblk0p1. Mar 10 15:20:16 volumiolounge systemd[1]: Mounting /boot... Mar 10 15:20:16 volumiolounge systemd-udevd[231]: Using default interface naming scheme 'v240'. Mar 10 15:20:16 volumiolounge systemd-udevd[231]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 10 15:20:16 volumiolounge systemd[1]: Mounted /boot. Mar 10 15:20:16 volumiolounge systemd[1]: Reached target Local File Systems. Mar 10 15:20:16 volumiolounge systemd[1]: Started ifup for eth0. Mar 10 15:20:16 volumiolounge systemd[1]: Starting Create Volatile Files and Directories... Mar 10 15:20:16 volumiolounge systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Mar 10 15:20:16 volumiolounge systemd[1]: Starting Preprocess NFS configuration... Mar 10 15:20:16 volumiolounge systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Mar 10 15:20:16 volumiolounge systemd[1]: Starting Raise network interfaces... Mar 10 15:20:16 volumiolounge systemd[1]: Started Load/Save RF Kill Switch Status. Mar 10 15:20:16 volumiolounge systemd[1]: nfs-config.service: Succeeded. Mar 10 15:20:16 volumiolounge systemd[1]: Started Preprocess NFS configuration. Mar 10 15:20:16 volumiolounge systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Mar 10 15:20:16 volumiolounge systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Mar 10 15:20:16 volumiolounge systemd[1]: Reached target NFS client services. Mar 10 15:20:16 volumiolounge systemd[1]: Started Create Volatile Files and Directories. Mar 10 15:20:16 volumiolounge systemd[1]: Starting RPC bind portmap service... Mar 10 15:20:16 volumiolounge systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Mar 10 15:20:16 volumiolounge systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Mar 10 15:20:16 volumiolounge systemd[1]: Starting Update UTMP about System Boot/Shutdown... Mar 10 15:20:16 volumiolounge systemd[1]: plymouth-read-write.service: Succeeded. Mar 10 15:20:16 volumiolounge systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Mar 10 15:20:16 volumiolounge systemd[1]: Received SIGRTMIN+20 from PID 261 (plymouthd). Mar 10 15:20:16 volumiolounge systemd[1]: Started Update UTMP about System Boot/Shutdown. Mar 10 15:20:17 volumiolounge systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Mar 10 15:20:17 volumiolounge systemd[1]: Started ifup for wlan0. Mar 10 15:20:17 volumiolounge systemd[1]: Reached target System Initialization. Mar 10 15:20:17 volumiolounge systemd[1]: Started Daily Cleanup of Temporary Directories. Mar 10 15:20:17 volumiolounge kernel: 8021q: 802.1Q VLAN Support v1.8 Mar 10 15:20:17 volumiolounge systemd[1]: Listening on mpd.socket. Mar 10 15:20:17 volumiolounge systemd[1]: Listening on triggerhappy.socket. Mar 10 15:20:17 volumiolounge systemd[1]: apt-daily.timer: Not using persistent file timestamp Fri 2024-03-22 13:17:29 UTC as it is in the future. Mar 10 15:20:17 volumiolounge systemd[1]: Started Daily apt download activities. Mar 10 15:20:17 volumiolounge systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Fri 2024-03-22 06:24:29 UTC as it is in the future. Mar 10 15:20:17 volumiolounge systemd[1]: Started Daily apt upgrade and clean activities. Mar 10 15:20:17 volumiolounge systemd[1]: Reached target Timers. Mar 10 15:20:17 volumiolounge systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Mar 10 15:20:17 volumiolounge systemd[1]: Listening on D-Bus System Message Bus Socket. Mar 10 15:20:17 volumiolounge systemd[1]: Reached target Sockets. Mar 10 15:20:17 volumiolounge systemd[1]: Reached target Basic System. Mar 10 15:20:17 volumiolounge systemd[1]: Starting Wireless Services... Mar 10 15:20:17 volumiolounge systemd[1]: Started Manage Sound Card State (restore and store). Mar 10 15:20:17 volumiolounge alsactl[473]: alsactl 1.1.8 daemon started Mar 10 15:20:17 volumiolounge systemd[1]: Starting triggerhappy global hotkey daemon... Mar 10 15:20:17 volumiolounge systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Mar 10 15:20:17 volumiolounge systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Mar 10 15:20:17 volumiolounge systemd[1]: Starting Configure Bluetooth Modems connected by UART... Mar 10 15:20:17 volumiolounge systemd[1]: Started D-Bus System Message Bus. Mar 10 15:20:17 volumiolounge thd[477]: Unable to parse trigger line: Mar 10 15:20:17 volumiolounge thd[477]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Mar 10 15:20:17 volumiolounge thd[477]: Unable to parse trigger line: Mar 10 15:20:17 volumiolounge thd[477]: Unable to parse trigger line: Mar 10 15:20:17 volumiolounge thd[477]: Found socket passed from systemd Mar 10 15:20:17 volumiolounge systemd[1]: Starting dhcpcd on all interfaces... Mar 10 15:20:17 volumiolounge systemd[1]: Started Volumio Iptables Module. Mar 10 15:20:17 volumiolounge systemd[1]: Started volumio-remote-updater.service. Mar 10 15:20:17 volumiolounge systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Mar 10 15:20:17 volumiolounge systemd[1]: Starting Login Service... Mar 10 15:20:17 volumiolounge systemd[1]: Starting Save/Restore Sound Card State... Mar 10 15:20:17 volumiolounge systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Mar 10 15:20:17 volumiolounge dhcpcd[491]: Not running dhcpcd because /etc/network/interfaces Mar 10 15:20:17 volumiolounge dhcpcd[491]: defines some interfaces that will use a Mar 10 15:20:17 volumiolounge dhcpcd[491]: DHCP client or static address Mar 10 15:20:17 volumiolounge systemd[1]: Starting WPA supplicant... Mar 10 15:20:17 volumiolounge systemd[1]: Started UPnP Renderer front-end to MPD. Mar 10 15:20:17 volumiolounge systemd[1]: Started RPC bind portmap service. Mar 10 15:20:17 volumiolounge systemd[1]: Started triggerhappy global hotkey daemon. Mar 10 15:20:17 volumiolounge kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 10 15:20:17 volumiolounge systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Mar 10 15:20:17 volumiolounge systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Mar 10 15:20:17 volumiolounge systemd[1]: Failed to start dhcpcd on all interfaces. Mar 10 15:20:17 volumiolounge systemd[1]: Reached target Remote File Systems (Pre). Mar 10 15:20:17 volumiolounge systemd[1]: Reached target Remote File Systems. Mar 10 15:20:17 volumiolounge systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Mar 10 15:20:17 volumiolounge systemd[1]: Reached target RPC Port Mapper. Mar 10 15:20:17 volumiolounge sh[403]: eth0: waiting for carrier Mar 10 15:20:17 volumiolounge dhcpcd[441]: eth0: waiting for carrier Mar 10 15:20:17 volumiolounge kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Mar 10 15:20:17 volumiolounge kernel: bcmgenet fd580000.ethernet eth0: Link is Down Mar 10 15:20:17 volumiolounge kernel: uart-pl011 fe201000.serial: no DMA platform data Mar 10 15:20:18 volumiolounge avahi-daemon[509]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Mar 10 15:20:18 volumiolounge avahi-daemon[509]: Successfully dropped root privileges. Mar 10 15:20:18 volumiolounge avahi-daemon[509]: avahi-daemon 0.7 starting up. Mar 10 15:20:18 volumiolounge systemd-logind[500]: New seat seat0. Mar 10 15:20:18 volumiolounge systemd[1]: Started Save/Restore Sound Card State. Mar 10 15:20:18 volumiolounge avahi-daemon[509]: Successfully called chroot(). Mar 10 15:20:18 volumiolounge avahi-daemon[509]: Successfully dropped remaining capabilities. Mar 10 15:20:18 volumiolounge avahi-daemon[509]: Loading service file /services/volumio.service. Mar 10 15:20:18 volumiolounge avahi-daemon[509]: Network interface enumeration completed. Mar 10 15:20:18 volumiolounge avahi-daemon[509]: Server startup complete. Host name is volumiolounge.local. Local service cookie is 1589875515. Mar 10 15:20:18 volumiolounge avahi-daemon[509]: Service "VolumioLounge" (/services/volumio.service) successfully established. Mar 10 15:20:18 volumiolounge sh[458]: wlan0=wlan0 Mar 10 15:20:18 volumiolounge systemd[1]: Started Login Service. Mar 10 15:20:18 volumiolounge systemd[1]: Started Avahi mDNS/DNS-SD Stack. Mar 10 15:20:18 volumiolounge systemd[1]: Reached target Sound Card. Mar 10 15:20:18 volumiolounge systemd[1]: Started Raise network interfaces. Mar 10 15:20:18 volumiolounge loadcpufreq[525]: Loading cpufreq kernel modules...done (none). Mar 10 15:20:18 volumiolounge systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Mar 10 15:20:18 volumiolounge systemd[1]: Starting LSB: set CPUFreq kernel parameters... Mar 10 15:20:19 volumiolounge cpufrequtils[600]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Mar 10 15:20:19 volumiolounge systemd[1]: Started LSB: set CPUFreq kernel parameters. Mar 10 15:20:19 volumiolounge systemd[1]: iptables.service: Succeeded. Mar 10 15:20:19 volumiolounge systemd[1]: Started WPA supplicant. Mar 10 15:20:19 volumiolounge systemd[1]: Reached target Network. Mar 10 15:20:19 volumiolounge systemd[1]: Starting Permit User Sessions... Mar 10 15:20:19 volumiolounge wpa_supplicant[513]: Successfully initialized wpa_supplicant Mar 10 15:20:19 volumiolounge systemd[1]: Starting Music Player Daemon... Mar 10 15:20:19 volumiolounge systemd[1]: Starting Network Time Service... Mar 10 15:20:19 volumiolounge systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Mar 10 15:20:19 volumiolounge systemd[1]: Reached target Network is Online. Mar 10 15:20:19 volumiolounge systemd[1]: Starting /etc/rc.local Compatibility... Mar 10 15:20:19 volumiolounge systemd[1]: Starting LSB: Brings up/down network automatically... Mar 10 15:20:19 volumiolounge systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 15:20:19 volumiolounge systemd[1]: Starting Samba NMB Daemon... Mar 10 15:20:19 volumiolounge systemd[1]: Started Permit User Sessions. Mar 10 15:20:19 volumiolounge systemd[1]: Started /etc/rc.local Compatibility. Mar 10 15:20:19 volumiolounge systemd[1]: Starting Terminate Plymouth Boot Screen... Mar 10 15:20:19 volumiolounge systemd[1]: Starting Hold until boot process finishes up... Mar 10 15:20:19 volumiolounge systemd[1]: Received SIGRTMIN+21 from PID 261 (plymouthd). Mar 10 15:20:19 volumiolounge systemd[1]: plymouth-start.service: Succeeded. Mar 10 15:20:19 volumiolounge systemd[1]: plymouth-quit.service: Succeeded. Mar 10 15:20:19 volumiolounge systemd[1]: Started Terminate Plymouth Boot Screen. Mar 10 15:20:19 volumiolounge systemd[1]: plymouth-quit-wait.service: Succeeded. Mar 10 15:20:19 volumiolounge systemd[1]: Started Hold until boot process finishes up. Mar 10 15:20:19 volumiolounge systemd[1]: Received SIGRTMIN+21 from PID 261 (n/a). Mar 10 15:20:19 volumiolounge systemd[1]: Started Getty on tty1. Mar 10 15:20:19 volumiolounge systemd[1]: Reached target Login Prompts. Mar 10 15:20:19 volumiolounge ifplugd(eth0)[648]: ifplugd 0.28 initializing. Mar 10 15:20:19 volumiolounge ifplugd(eth0)[648]: Using interface eth0/DC:A6:32:85:FF:57 with driver (version: 5.10.92-v7l+) Mar 10 15:20:19 volumiolounge ifplugd(eth0)[648]: Using detection mode: SIOCETHTOOL Mar 10 15:20:19 volumiolounge ifplugd(eth0)[648]: Initialization complete, link beat not detected. Mar 10 15:20:19 volumiolounge volumio-remote-updater[496]: Error: No active session Mar 10 15:20:19 volumiolounge volumio-remote-updater[496]: [2024-03-10 15:20:19] [info] asio async_connect error: system:111 (Connection refused) Mar 10 15:20:19 volumiolounge volumio-remote-updater[496]: [2024-03-10 15:20:19] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 10 15:20:19 volumiolounge volumio-remote-updater[496]: [2024-03-10 15:20:19] [error] handle_connect error: Underlying Transport Error Mar 10 15:20:19 volumiolounge ifplugd[624]: Network Interface Plugging Daemon...start eth0...done. Mar 10 15:20:19 volumiolounge systemd[1]: Started LSB: Brings up/down network automatically. Mar 10 15:20:19 volumiolounge haveged[426]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Mar 10 15:20:19 volumiolounge haveged[426]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Mar 10 15:20:19 volumiolounge haveged[426]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00237 Mar 10 15:20:19 volumiolounge haveged[426]: haveged: fills: 0, generated: 0 Mar 10 15:20:19 volumiolounge ntpd[622]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 10 15:20:19 volumiolounge ntpd[622]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Mar 10 15:20:19 volumiolounge systemd[1]: Started Network Time Service. Mar 10 15:20:19 volumiolounge ntpd[654]: proto: precision = 0.778 usec (-20) Mar 10 15:20:19 volumiolounge kernel: random: crng init done Mar 10 15:20:19 volumiolounge kernel: random: 7 urandom warning(s) missed due to ratelimiting Mar 10 15:20:19 volumiolounge ntpd[654]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 10 15:20:19 volumiolounge ntpd[654]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2023-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 10 15:20:19 volumiolounge ntpd[654]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 74 days ago Mar 10 15:20:19 volumiolounge ntpd[654]: Listen and drop on 0 v6wildcard [::]:123 Mar 10 15:20:19 volumiolounge ntpd[654]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 10 15:20:19 volumiolounge ntpd[654]: Listen normally on 2 lo 127.0.0.1:123 Mar 10 15:20:19 volumiolounge ntpd[654]: Listening on routing socket on fd #19 for interface updates Mar 10 15:20:19 volumiolounge ntpd[654]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 10 15:20:19 volumiolounge ntpd[654]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 10 15:20:20 volumiolounge volumio[514]: Could not open config: /tmp/upmpdcli.conf Mar 10 15:20:20 volumiolounge systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 10 15:20:20 volumiolounge systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 10 15:20:20 volumiolounge ntpd[654]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 10 15:20:21 volumiolounge nmbd[630]: [2024/03/10 15:20:21.397683, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Mar 10 15:20:21 volumiolounge nmbd[630]: started asyncdns process 661 Mar 10 15:20:21 volumiolounge nmbd[630]: [2024/03/10 15:20:21.400439, 0] ../lib/util/become_daemon.c:149(daemon_status) Mar 10 15:20:21 volumiolounge nmbd[630]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Mar 10 15:20:21 volumiolounge nmbd[630]: [2024/03/10 15:20:21.400594, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Mar 10 15:20:21 volumiolounge nmbd[630]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Mar 10 15:20:21 volumiolounge systemd[1]: systemd-rfkill.service: Succeeded. Mar 10 15:20:21 volumiolounge ntpd[654]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 10 15:20:22 volumiolounge wireless.js[471]: Cleaning previous... Mar 10 15:20:22 volumiolounge sudo[670]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 10 15:20:22 volumiolounge sudo[670]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:22 volumiolounge sudo[670]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:22 volumiolounge sudo[672]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 10 15:20:22 volumiolounge sudo[672]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:22 volumiolounge mpd[638]: Mar 10 15:20 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 10 15:20:22 volumiolounge mpd[638]: Mar 10 15:20 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Mar 10 15:20:22 volumiolounge mpd[638]: Mar 10 15:20 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Mar 10 15:20:22 volumiolounge sudo[672]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:22 volumiolounge systemd[1]: Started Music Player Daemon. Mar 10 15:20:22 volumiolounge wireless.js[471]: Stopped aP Mar 10 15:20:22 volumiolounge ntpd[654]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 10 15:20:22 volumiolounge sudo[681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 10 15:20:22 volumiolounge sudo[681]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:22 volumiolounge sudo[681]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:22 volumiolounge kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 10 15:20:22 volumiolounge sudo[683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Mar 10 15:20:22 volumiolounge sudo[683]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:22 volumiolounge sudo[683]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:22 volumiolounge sudo[690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 10 15:20:22 volumiolounge sudo[690]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:22 volumiolounge sudo[690]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:23 volumiolounge sudo[692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Mar 10 15:20:23 volumiolounge sudo[692]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:23 volumiolounge ntpd[654]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 10 15:20:24 volumiolounge volumio-remote-updater[496]: [2024-03-10 15:20:24] [info] asio async_connect error: system:111 (Connection refused) Mar 10 15:20:24 volumiolounge volumio-remote-updater[496]: [2024-03-10 15:20:24] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 10 15:20:24 volumiolounge volumio-remote-updater[496]: [2024-03-10 15:20:24] [error] handle_connect error: Underlying Transport Error Mar 10 15:20:25 volumiolounge kernel: Bluetooth: Core ver 2.22 Mar 10 15:20:25 volumiolounge kernel: NET: Registered protocol family 31 Mar 10 15:20:25 volumiolounge kernel: Bluetooth: HCI device and connection manager initialized Mar 10 15:20:25 volumiolounge kernel: Bluetooth: HCI socket layer initialized Mar 10 15:20:25 volumiolounge kernel: Bluetooth: L2CAP socket layer initialized Mar 10 15:20:25 volumiolounge kernel: Bluetooth: SCO socket layer initialized Mar 10 15:20:25 volumiolounge btuart[480]: bcm43xx_init Mar 10 15:20:25 volumiolounge btuart[480]: Flash firmware /lib/firmware/brcm/BCM4345C0.hcd Mar 10 15:20:25 volumiolounge btuart[480]: Set Controller UART speed to 3000000 bit/s Mar 10 15:20:25 volumiolounge btuart[480]: Device setup complete Mar 10 15:20:25 volumiolounge systemd[1]: Starting Load/Save RF Kill Switch Status... Mar 10 15:20:25 volumiolounge kernel: Bluetooth: HCI UART driver ver 2.3 Mar 10 15:20:25 volumiolounge kernel: Bluetooth: HCI UART protocol H4 registered Mar 10 15:20:25 volumiolounge kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Mar 10 15:20:25 volumiolounge kernel: Bluetooth: HCI UART protocol Broadcom registered Mar 10 15:20:25 volumiolounge systemd[1]: Started Configure Bluetooth Modems connected by UART. Mar 10 15:20:25 volumiolounge systemd[1]: Started Load/Save RF Kill Switch Status. Mar 10 15:20:25 volumiolounge systemd[1]: Created slice system-bthelper.slice. Mar 10 15:20:25 volumiolounge systemd[1]: Starting Raspberry Pi bluetooth helper... Mar 10 15:20:25 volumiolounge bthelper[707]: Raspberry Pi BDADDR already set Mar 10 15:20:25 volumiolounge systemd[1]: Started Raspberry Pi bluetooth helper. Mar 10 15:20:25 volumiolounge systemd[1]: Starting Bluetooth service... Mar 10 15:20:25 volumiolounge bluetoothd[717]: Bluetooth daemon 5.50 Mar 10 15:20:25 volumiolounge bluetoothd[717]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Mar 10 15:20:25 volumiolounge systemd[1]: Started Bluetooth service. Mar 10 15:20:25 volumiolounge systemd[1]: Reached target Bluetooth. Mar 10 15:20:25 volumiolounge bluetoothd[717]: Starting SDP server Mar 10 15:20:25 volumiolounge bluetoothd[717]: Excluding (cli) sap Mar 10 15:20:25 volumiolounge bluetoothd[717]: Bluetooth management interface 1.18 initialized Mar 10 15:20:25 volumiolounge dbus-daemon[486]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=717 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Mar 10 15:20:25 volumiolounge kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Mar 10 15:20:25 volumiolounge kernel: Bluetooth: BNEP filters: protocol multicast Mar 10 15:20:25 volumiolounge kernel: Bluetooth: BNEP socket layer initialized Mar 10 15:20:25 volumiolounge systemd[1]: Starting Hostname Service... Mar 10 15:20:25 volumiolounge dbus-daemon[486]: [system] Successfully activated service 'org.freedesktop.hostname1' Mar 10 15:20:25 volumiolounge systemd[1]: Started Hostname Service. Mar 10 15:20:25 volumiolounge bluetoothd[717]: Failed to set privacy: Rejected (0x0b) Mar 10 15:20:25 volumiolounge sudo[692]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:25 volumiolounge wireless.js[471]: Start wireless flow Mar 10 15:20:25 volumiolounge wireless.js[471]: Stopped hotspot (if there).. Mar 10 15:20:25 volumiolounge sudo[721]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 10 15:20:25 volumiolounge sudo[721]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:25 volumiolounge sudo[721]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:25 volumiolounge sudo[723]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 10 15:20:25 volumiolounge sudo[723]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:26 volumiolounge sudo[723]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:26 volumiolounge wireless.js[471]: DHCP IP Mar 10 15:20:26 volumiolounge wireless.js[471]: Start ap Mar 10 15:20:26 volumiolounge wpa_supplicant[725]: Successfully initialized wpa_supplicant Mar 10 15:20:26 volumiolounge sudo[726]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Mar 10 15:20:26 volumiolounge sudo[726]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:26 volumiolounge dhcpcd[727]: dev: loaded udev Mar 10 15:20:26 volumiolounge kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 10 15:20:26 volumiolounge dhcpcd-run-hooks[745]: wlan0: starting wpa_supplicant Mar 10 15:20:26 volumiolounge dhcpcd-run-hooks[750]: wlan0: failed to start wpa_supplicant Mar 10 15:20:26 volumiolounge dhcpcd-run-hooks[751]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Mar 10 15:20:26 volumiolounge dhcpcd[727]: wlan0: connected to Access Point `' Mar 10 15:20:26 volumiolounge dhcpcd[727]: no interfaces have a carrier Mar 10 15:20:26 volumiolounge dhcpcd[727]: forked to background, child pid 761 Mar 10 15:20:26 volumiolounge dhcpcd[761]: eth0: waiting for carrier Mar 10 15:20:26 volumiolounge dhcpcd[761]: wlan0: waiting for carrier Mar 10 15:20:26 volumiolounge sudo[726]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:27 volumiolounge wireless.js[471]: trying... Mar 10 15:20:27 volumiolounge sudo[763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:27 volumiolounge sudo[763]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:27 volumiolounge sudo[763]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:28 volumiolounge wireless.js[471]: trying... Mar 10 15:20:28 volumiolounge sudo[766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:28 volumiolounge sudo[766]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:28 volumiolounge sudo[766]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:28 volumiolounge wpa_supplicant[749]: wlan0: Trying to associate with SSID 'ORBIROSARY' Mar 10 15:20:29 volumiolounge wireless.js[471]: trying... Mar 10 15:20:29 volumiolounge sudo[769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:29 volumiolounge sudo[769]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:29 volumiolounge sudo[769]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:30 volumiolounge systemd[1]: systemd-rfkill.service: Succeeded. Mar 10 15:20:30 volumiolounge bthelper[707]: Changing power off succeeded Mar 10 15:20:30 volumiolounge wireless.js[471]: trying... Mar 10 15:20:30 volumiolounge sudo[773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:30 volumiolounge sudo[773]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:30 volumiolounge sudo[773]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:30 volumiolounge bthelper[707]: [CHG] Controller DC:A6:32:85:FF:59 Class: 0x0000041c Mar 10 15:20:30 volumiolounge bthelper[707]: Changing power on succeeded Mar 10 15:20:31 volumiolounge wireless.js[471]: trying... Mar 10 15:20:31 volumiolounge sudo[782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:31 volumiolounge sudo[782]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:31 volumiolounge sudo[782]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:31 volumiolounge dhcpcd[761]: wlan0: carrier acquired Mar 10 15:20:31 volumiolounge dhcpcd[761]: wlan0: connected to Access Point `ORBIROSARY' Mar 10 15:20:31 volumiolounge wpa_supplicant[749]: wlan0: Associated with e4:38:83:25:ca:8b Mar 10 15:20:31 volumiolounge wpa_supplicant[749]: wlan0: CTRL-EVENT-CONNECTED - Connection to e4:38:83:25:ca:8b completed [id=0 id_str=] Mar 10 15:20:31 volumiolounge wpa_supplicant[749]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 10 15:20:31 volumiolounge dhcpcd[761]: DUID 00:01:00:01:29:53:65:c6:dc:a6:32:85:ff:58 Mar 10 15:20:31 volumiolounge dhcpcd[761]: wlan0: IAID 32:85:ff:58 Mar 10 15:20:31 volumiolounge dhcpcd[761]: wlan0: adding address fe80::360d:eb0e:73df:1f63 Mar 10 15:20:31 volumiolounge dhcpcd[761]: ipv6_addaddr1: Permission denied Mar 10 15:20:31 volumiolounge dhcpcd[761]: wlan0: carrier lost Mar 10 15:20:31 volumiolounge dhcpcd[761]: wlan0: carrier acquired Mar 10 15:20:31 volumiolounge wpa_supplicant[749]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=GB Mar 10 15:20:31 volumiolounge dhcpcd[761]: wlan0: IAID 32:85:ff:58 Mar 10 15:20:31 volumiolounge dhcpcd[761]: wlan0: rebinding lease of 192.168.30.10 Mar 10 15:20:31 volumiolounge dhcpcd[761]: wlan0: probing address 192.168.30.10/24 Mar 10 15:20:32 volumiolounge wireless.js[471]: trying... Mar 10 15:20:32 volumiolounge sudo[798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:32 volumiolounge sudo[798]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:32 volumiolounge sudo[798]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:32 volumiolounge volumio-remote-updater[496]: [2024-03-10 15:20:32] [info] asio async_connect error: system:111 (Connection refused) Mar 10 15:20:32 volumiolounge volumio-remote-updater[496]: [2024-03-10 15:20:32] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 10 15:20:32 volumiolounge volumio-remote-updater[496]: [2024-03-10 15:20:32] [error] handle_connect error: Underlying Transport Error Mar 10 15:20:32 volumiolounge dhcpcd[761]: wlan0: soliciting an IPv6 router Mar 10 15:20:32 volumiolounge kernel: cam-dummy-reg: disabling Mar 10 15:20:32 volumiolounge kernel: cam1-reg: disabling Mar 10 15:20:33 volumiolounge wireless.js[471]: trying... Mar 10 15:20:33 volumiolounge sudo[801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:33 volumiolounge sudo[801]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:33 volumiolounge sudo[801]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:34 volumiolounge wireless.js[471]: trying... Mar 10 15:20:34 volumiolounge sudo[804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:34 volumiolounge sudo[804]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:34 volumiolounge sudo[804]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:35 volumiolounge wireless.js[471]: trying... Mar 10 15:20:35 volumiolounge sudo[807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:35 volumiolounge sudo[807]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:35 volumiolounge sudo[807]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:36 volumiolounge wireless.js[471]: trying... Mar 10 15:20:36 volumiolounge sudo[810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:36 volumiolounge sudo[810]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:36 volumiolounge sudo[810]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:37 volumiolounge wireless.js[471]: trying... Mar 10 15:20:37 volumiolounge sudo[813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:37 volumiolounge sudo[813]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:37 volumiolounge sudo[813]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:37 volumiolounge dhcpcd[761]: wlan0: leased 192.168.30.10 for 86400 seconds Mar 10 15:20:37 volumiolounge avahi-daemon[509]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.30.10. Mar 10 15:20:37 volumiolounge dhcpcd[761]: wlan0: adding route to 192.168.30.0/24 Mar 10 15:20:37 volumiolounge avahi-daemon[509]: New relevant interface wlan0.IPv4 for mDNS. Mar 10 15:20:37 volumiolounge avahi-daemon[509]: Registering new address record for 192.168.30.10 on wlan0.IPv4. Mar 10 15:20:37 volumiolounge dhcpcd[761]: wlan0: adding default route via 192.168.30.1 Mar 10 15:20:38 volumiolounge wireless.js[471]: trying... Mar 10 15:20:38 volumiolounge sudo[836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 10 15:20:38 volumiolounge sudo[836]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:38 volumiolounge sudo[836]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:38 volumiolounge wireless.js[471]: Connected to: ----ORBIROSARY Mar 10 15:20:38 volumiolounge wireless.js[471]: ---- Mar 10 15:20:38 volumiolounge sudo[839]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 15:20:38 volumiolounge sudo[839]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:38 volumiolounge sudo[839]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:38 volumiolounge wireless.js[471]: ... joined AP, wlan0 IPv4 is 192.168.30.10, ipV6 is undefined Mar 10 15:20:38 volumiolounge wireless.js[471]: It's done! AP Mar 10 15:20:38 volumiolounge systemd[1]: Started Wireless Services. Mar 10 15:20:38 volumiolounge kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 10 15:20:38 volumiolounge systemd[1]: Started Volumio Backend Module. Mar 10 15:20:38 volumiolounge ntpd[654]: Listen normally on 3 wlan0 192.168.30.10:123 Mar 10 15:20:38 volumiolounge ntpd[654]: new interface(s) found: waking up resolver Mar 10 15:20:40 volumiolounge volumio[844]: info: ------------------------------------------- Mar 10 15:20:40 volumiolounge volumio[844]: info: ----- Volumio3 ---- Mar 10 15:20:40 volumiolounge volumio[844]: info: ------------------------------------------- Mar 10 15:20:40 volumiolounge volumio[844]: info: ----- System startup ---- Mar 10 15:20:40 volumiolounge volumio[844]: info: ------------------------------------------- Mar 10 15:20:40 volumiolounge volumio[844]: info: MYVOLUMIO Environment detected Mar 10 15:20:40 volumiolounge volumio[844]: info: Plugin folders cleanup Mar 10 15:20:40 volumiolounge volumio[844]: info: Scanning into folder /volumio/app/plugins/ Mar 10 15:20:40 volumiolounge volumio[844]: info: Scanning category audio_interface Mar 10 15:20:40 volumiolounge volumio[844]: info: Scanning category miscellanea Mar 10 15:20:40 volumiolounge volumio[844]: info: Scanning category music_service Mar 10 15:20:40 volumiolounge volumio[844]: info: Scanning category plugins.json Mar 10 15:20:40 volumiolounge volumio[844]: info: Scanning category system_controller Mar 10 15:20:40 volumiolounge volumio[844]: info: Scanning category user_interface Mar 10 15:20:40 volumiolounge volumio[844]: info: Scanning into folder /data/plugins/ Mar 10 15:20:40 volumiolounge volumio[844]: info: Scanning category music_service Mar 10 15:20:40 volumiolounge volumio[844]: info: Plugin folders cleanup completed Mar 10 15:20:40 volumiolounge volumio[844]: info: ------------------------------------------- Mar 10 15:20:40 volumiolounge volumio[844]: info: ----- Core plugins startup ---- Mar 10 15:20:40 volumiolounge volumio[844]: info: ------------------------------------------- Mar 10 15:20:40 volumiolounge volumio[844]: info: Loading plugins from folder /volumio/app/plugins/ Mar 10 15:20:41 volumiolounge volumio[844]: info: Adding plugin upnp to MyMusic Plugins Mar 10 15:20:41 volumiolounge volumio[844]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 10 15:20:41 volumiolounge volumio[844]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 10 15:20:41 volumiolounge volumio[844]: info: Loading plugins from folder /data/plugins/ Mar 10 15:20:41 volumiolounge volumio[844]: info: Loading plugin "system"... Mar 10 15:20:41 volumiolounge volumio[844]: info: Loading plugin "appearance"... Mar 10 15:20:41 volumiolounge nmbd[630]: [2024/03/10 15:20:41.408815, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 10 15:20:41 volumiolounge nmbd[630]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 10 15:20:41 volumiolounge systemd[1]: Started Samba NMB Daemon. Mar 10 15:20:41 volumiolounge systemd[1]: Starting Samba Winbind Daemon... Mar 10 15:20:41 volumiolounge winbindd[861]: [2024/03/10 15:20:41.731761, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 10 15:20:41 volumiolounge winbindd[861]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 10 15:20:41 volumiolounge winbindd[861]: [2024/03/10 15:20:41.768351, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 10 15:20:41 volumiolounge systemd[1]: Started Samba Winbind Daemon. Mar 10 15:20:41 volumiolounge winbindd[861]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 10 15:20:41 volumiolounge systemd[1]: Starting Samba SMB Daemon... Mar 10 15:20:42 volumiolounge systemd[1]: Started Samba SMB Daemon. Mar 10 15:20:42 volumiolounge systemd[1]: Reached target Multi-User System. Mar 10 15:20:42 volumiolounge systemd[1]: Reached target Graphical Interface. Mar 10 15:20:42 volumiolounge systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 10 15:20:42 volumiolounge smbd[866]: [2024/03/10 15:20:42.211188, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 10 15:20:42 volumiolounge smbd[866]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 10 15:20:42 volumiolounge systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 10 15:20:42 volumiolounge systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 10 15:20:42 volumiolounge systemd[1]: Startup finished in 10.733s (kernel) + 31.971s (userspace) = 42.705s. Mar 10 15:20:42 volumiolounge volumio[844]: info: Loading plugin "network"... Mar 10 15:20:42 volumiolounge volumio[844]: info: Refreshing Cached IP Addresses Mar 10 15:20:42 volumiolounge sudo[876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 15:20:42 volumiolounge sudo[876]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:42 volumiolounge sudo[876]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:42 volumiolounge sudo[878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 15:20:42 volumiolounge sudo[878]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:42 volumiolounge volumio[844]: info: Loading plugin "services"... Mar 10 15:20:42 volumiolounge volumio[844]: info: Loading plugin "alsa_controller"... Mar 10 15:20:42 volumiolounge sudo[878]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:42 volumiolounge sudo[881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 10 15:20:42 volumiolounge sudo[881]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:42 volumiolounge volumio-remote-updater[496]: [2024-03-10 15:20:42] [connect] Successful connection Mar 10 15:20:42 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 15:20:42 volumiolounge volumio[844]: info: Loading plugin "wizard"... Mar 10 15:20:42 volumiolounge volumio[844]: info: Loading plugin "volumio_command_line_client"... Mar 10 15:20:42 volumiolounge volumio[844]: info: Loading plugin "upnp"... Mar 10 15:20:42 volumiolounge volumio[844]: info: [1710084042409] Starting Upmpd Daemon Mar 10 15:20:42 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 10 15:20:42 volumiolounge volumio[844]: info: Loading plugin "my_music"... Mar 10 15:20:42 volumiolounge volumio[844]: info: Loading plugin "mpd"... Mar 10 15:20:42 volumiolounge volumio[844]: info: Creating MPD Configuration file Mar 10 15:20:42 volumiolounge volumio[844]: info: Loading plugin "upnp_browser"... Mar 10 15:20:42 volumiolounge sudo[887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 15:20:42 volumiolounge sudo[887]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:42 volumiolounge sudo[887]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:42 volumiolounge sudo[889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 15:20:42 volumiolounge sudo[889]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:42 volumiolounge systemd[1]: Stopping Music Player Daemon... Mar 10 15:20:43 volumiolounge systemd[1]: mpd.service: Succeeded. Mar 10 15:20:43 volumiolounge systemd[1]: Stopped Music Player Daemon. Mar 10 15:20:43 volumiolounge systemd[1]: Starting Music Player Daemon... Mar 10 15:20:43 volumiolounge volumio[844]: info: Loading plugin "networkfs"... Mar 10 15:20:43 volumiolounge volumio[844]: info: Starting Udev Watcher for removable devices Mar 10 15:20:43 volumiolounge sudo[897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=volumio,password=helenjrees21,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.15/Music /mnt/NAS/Truenas Mar 10 15:20:43 volumiolounge sudo[897]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:43 volumiolounge kernel: FS-Cache: Netfs 'cifs' registered for caching Mar 10 15:20:43 volumiolounge kernel: Key type cifs.spnego registered Mar 10 15:20:43 volumiolounge kernel: Key type cifs.idmap registered Mar 10 15:20:43 volumiolounge kernel: CIFS: Attempting to mount //192.168.10.15/Music Mar 10 15:20:43 volumiolounge kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Mar 10 15:20:43 volumiolounge mpd[894]: Mar 10 15:20 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 10 15:20:43 volumiolounge volumio[844]: info: Ignoring mount for partition: boot Mar 10 15:20:43 volumiolounge volumio[844]: info: Ignoring mount for partition: volumio Mar 10 15:20:43 volumiolounge volumio[844]: info: Ignoring mount for partition: volumio_data Mar 10 15:20:43 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 10 15:20:43 volumiolounge volumio[844]: info: Loading plugin "alarm-clock"... Mar 10 15:20:43 volumiolounge mpd[894]: Mar 10 15:20 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Mar 10 15:20:43 volumiolounge mpd[894]: Mar 10 15:20 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Mar 10 15:20:43 volumiolounge systemd[1]: Started Music Player Daemon. Mar 10 15:20:43 volumiolounge sudo[889]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:43 volumiolounge volumio[844]: info: Loading plugin "airplay_emulation"... Mar 10 15:20:44 volumiolounge volumio[844]: info: Starting Shairport Sync Mar 10 15:20:44 volumiolounge volumio[844]: info: Loading plugin "last_100"... Mar 10 15:20:44 volumiolounge volumio[844]: info: Loading plugin "webradio"... Mar 10 15:20:44 volumiolounge volumio[844]: info: Loading plugin "i2s_dacs"... Mar 10 15:20:44 volumiolounge volumio[844]: info: Loading plugin "volumiodiscovery"... Mar 10 15:20:44 volumiolounge sudo[897]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:44 volumiolounge volumio[844]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 10 15:20:44 volumiolounge node[844]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 10 15:20:44 volumiolounge volumio[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 15:20:44 volumiolounge node[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 15:20:44 volumiolounge volumio[844]: *** WARNING *** For more information see Mar 10 15:20:44 volumiolounge node[844]: *** WARNING *** For more information see Mar 10 15:20:44 volumiolounge volumio[844]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 10 15:20:44 volumiolounge node[844]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 10 15:20:44 volumiolounge volumio[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 15:20:44 volumiolounge node[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 15:20:44 volumiolounge volumio[844]: *** WARNING *** For more information see Mar 10 15:20:44 volumiolounge node[844]: *** WARNING *** For more information see Mar 10 15:20:44 volumiolounge volumio[844]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 10 15:20:44 volumiolounge volumio[844]: info: Discovery: Started advertising with name: VolumioLounge Mar 10 15:20:44 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 10 15:20:44 volumiolounge volumio[844]: info: Loading plugin "outputs"... Mar 10 15:20:44 volumiolounge volumio[844]: info: Loading plugin "albumart"... Mar 10 15:20:44 volumiolounge volumio[844]: info: Plugin example_plugin is not enabled Mar 10 15:20:44 volumiolounge volumio[844]: info: Loading plugin "inputs"... Mar 10 15:20:44 volumiolounge volumio[844]: info: Loading plugin "updater_comm"... Mar 10 15:20:44 volumiolounge volumio[844]: info: Plugin mpdemulation is not enabled Mar 10 15:20:44 volumiolounge volumio[844]: info: Loading plugin "rest_api"... Mar 10 15:20:44 volumiolounge volumio[844]: info: Loading plugin "websocket"... Mar 10 15:20:44 volumiolounge volumio[844]: info: Loading plugin "volspotconnect2"... Mar 10 15:20:44 volumiolounge volumio[844]: Forking 3 albumart workers Mar 10 15:20:45 volumiolounge volumio[844]: Starting albumart workers Mar 10 15:20:45 volumiolounge volumio[844]: Starting albumart workers Mar 10 15:20:45 volumiolounge volumio[844]: Starting albumart workers Mar 10 15:20:45 volumiolounge volumio[844]: info: Loading i18n strings for locale en Mar 10 15:20:45 volumiolounge volumio[844]: Updating browse sources language Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::initPlayerControls Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: Express server listening on port 3000 Mar 10 15:20:45 volumiolounge volumio[844]: [Metrics] WebUI: 6s 62.59ms Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreStateMachine::resetVolumioState Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreStateMachine::getcurrentVolume Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreStateMachine::pushState Mar 10 15:20:45 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushState Mar 10 15:20:45 volumiolounge volumio[844]: info: MPD Permissions set Mar 10 15:20:45 volumiolounge volumio-remote-updater[496]: [2024-03-10 15:20:45] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1710084042 101 Mar 10 15:20:45 volumiolounge volumio[844]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Mar 10 15:20:45 volumiolounge volumio[844]: info: MPD running with PID894 Mar 10 15:20:45 volumiolounge volumio[844]: ,establishing connection Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: Reloading queue from file Mar 10 15:20:45 volumiolounge volumio[844]: error: updateQueue error: null Mar 10 15:20:45 volumiolounge volumio[844]: info: Setting Device type: Raspberry PI Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreStateMachine::setRepeat null single undefined Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreStateMachine::pushState Mar 10 15:20:45 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushState Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreStateMachine::setRandom null Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreStateMachine::pushState Mar 10 15:20:45 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushState Mar 10 15:20:45 volumiolounge volumio[844]: info: Completed loading Core Plugins Mar 10 15:20:45 volumiolounge volumio[844]: info: Preparing to generate the ALSA configuration file Mar 10 15:20:45 volumiolounge volumio[844]: error: updateQueue error: null Mar 10 15:20:45 volumiolounge volumio[844]: info: Asound.conf file unchanged, so no further update is needed Mar 10 15:20:45 volumiolounge volumio[844]: info: Output device has changed, restarting MPD Mar 10 15:20:45 volumiolounge sudo[995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 15:20:45 volumiolounge sudo[995]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:45 volumiolounge volumio[844]: info: Output device has changed, restarting Shairport Sync Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 15:20:45 volumiolounge sudo[995]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:45 volumiolounge sudo[998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 15:20:45 volumiolounge sudo[998]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:45 volumiolounge systemd[1]: Stopping Music Player Daemon... Mar 10 15:20:45 volumiolounge volumio[844]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 15:20:45 volumiolounge volumio[844]: info: ___________ START PLUGINS ___________ Mar 10 15:20:45 volumiolounge systemd[1]: mpd.service: Succeeded. Mar 10 15:20:45 volumiolounge systemd[1]: Stopped Music Player Daemon. Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 15:20:45 volumiolounge volumio[844]: info: [1710084045957] CoreMusicLibrary::Adding element Media Servers Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 15:20:45 volumiolounge systemd[1]: Starting Music Player Daemon... Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:45 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 15:20:46 volumiolounge volumio[844]: info: [1710084046056] CoreMusicLibrary::Adding element Last_100 Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 15:20:46 volumiolounge volumio[844]: info: [1710084046059] CoreMusicLibrary::Adding element Webradio Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 15:20:46 volumiolounge volumio[844]: [SpotifyConnect] Creating VLS config file Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: [SpotifyConnect] <> or Mixer found, using softvol Mar 10 15:20:46 volumiolounge volumio[844]: [SpotifyConnect] Starting metadata listener Mar 10 15:20:46 volumiolounge sudo[881]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:46 volumiolounge volumio[844]: info: Volumio Calling Home Mar 10 15:20:46 volumiolounge sudo[1013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Mar 10 15:20:46 volumiolounge sudo[1013]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:46 volumiolounge systemd[1]: Started Volspotconnect2 Daemon. Mar 10 15:20:46 volumiolounge sudo[1013]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:46 volumiolounge volumio[844]: info: Discovery: adding 8f073129-3e01-4b4c-a224-be89dd6ff208 Mar 10 15:20:46 volumiolounge volumio[844]: info: Discovery: Found device VolumioLounge Mar 10 15:20:46 volumiolounge volumio[1017]: vollibrespot v0.2.3 769ce77 2021-06-04 (librespot 08d8bcc 2020-10-07) -- Built On 2021-06-04 Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:20:46 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:46 volumiolounge volumio[1017]: Reading Config from "volspotify.toml" Mar 10 15:20:46 volumiolounge volumio[1017]: [Vollibrespot] : Using Alsa backend with device: volumio Mar 10 15:20:46 volumiolounge volumio[844]: [SpotifyConnect] Vollibrespot Daemon service started! Mar 10 15:20:46 volumiolounge volumio[844]: [Metrics] SpotifyConnect: 0s 200.91ms Mar 10 15:20:46 volumiolounge volumio[844]: info: Completed starting Core Plugins Mar 10 15:20:46 volumiolounge volumio[844]: info: ------------------------------------------- Mar 10 15:20:46 volumiolounge volumio[844]: info: ----- MyVolumio plugins startup ---- Mar 10 15:20:46 volumiolounge volumio[844]: info: ------------------------------------------- Mar 10 15:20:46 volumiolounge volumio[844]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 10 15:20:46 volumiolounge volumio[844]: info: MPD Permissions set Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 15:20:46 volumiolounge volumio[844]: info: Discovery: Getting this device information Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:20:46 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 15:20:46 volumiolounge volumio[844]: info: Volumio called home Mar 10 15:20:46 volumiolounge volumio[844]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:20:46 volumiolounge volumio[1017]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Mar 10 15:20:46 volumiolounge volumio[844]: verbose: New Socket.io Connection to 192.168.30.10:3000 from 192.168.30.239 UA: Dart/3.5 (dart:io) Total Clients: 3 Mar 10 15:20:46 volumiolounge systemd[1]: systemd-fsckd.service: Succeeded. Mar 10 15:20:46 volumiolounge volumio[844]: info: Starting Shairport Sync Mar 10 15:20:46 volumiolounge volumio[844]: info: Starting Shairport Sync Mar 10 15:20:46 volumiolounge sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 15:20:46 volumiolounge volumio[844]: info: Starting Shairport Sync Mar 10 15:20:46 volumiolounge sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:46 volumiolounge sudo[1027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 15:20:46 volumiolounge sudo[1027]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:46 volumiolounge systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 15:20:46 volumiolounge systemd[1]: shairport-sync.service: Succeeded. Mar 10 15:20:46 volumiolounge systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 15:20:46 volumiolounge systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 15:20:46 volumiolounge sudo[1031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 15:20:46 volumiolounge sudo[1027]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:46 volumiolounge sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:46 volumiolounge sudo[1025]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:46 volumiolounge systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 15:20:46 volumiolounge systemd[1]: shairport-sync.service: Succeeded. Mar 10 15:20:46 volumiolounge systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 15:20:46 volumiolounge systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 15:20:46 volumiolounge sudo[1031]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:46 volumiolounge volumio[844]: info: Shairport-Sync Started Mar 10 15:20:46 volumiolounge volumio[844]: Error adding Membership: Error: addMembership EINVAL Mar 10 15:20:46 volumiolounge volumio[844]: info: Shairport-Sync Started Mar 10 15:20:46 volumiolounge volumio[844]: info: Shairport-Sync Started Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:20:46 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:20:46 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 10 15:20:46 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 10 15:20:46 volumiolounge mpd[1012]: Mar 10 15:20 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 10 15:20:46 volumiolounge mpd[1012]: Mar 10 15:20 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Mar 10 15:20:46 volumiolounge mpd[1012]: Mar 10 15:20 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Mar 10 15:20:46 volumiolounge systemd[1]: Started Music Player Daemon. Mar 10 15:20:46 volumiolounge sudo[998]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:46 volumiolounge volumio[844]: error: updateQueue error: null Mar 10 15:20:47 volumiolounge sh[403]: timed out Mar 10 15:20:47 volumiolounge dhcpcd[441]: timed out Mar 10 15:20:47 volumiolounge sh[403]: dhcpcd exited Mar 10 15:20:47 volumiolounge dhcpcd[441]: dhcpcd exited Mar 10 15:20:47 volumiolounge sh[403]: ifup: failed to bring up eth0 Mar 10 15:20:47 volumiolounge systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Mar 10 15:20:47 volumiolounge systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Mar 10 15:20:47 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:20:47 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:20:48 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:20:49 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:20:49 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:49 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:20:49 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:20:50 volumiolounge sudo[1042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 15:20:50 volumiolounge sudo[1042]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:50 volumiolounge sudo[1042]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:50 volumiolounge sudo[1044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 15:20:50 volumiolounge sudo[1044]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:50 volumiolounge sudo[1044]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:50 volumiolounge volumio[844]: verbose: New Socket.io Connection to 192.168.30.10 from 192.168.30.239 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 4 Mar 10 15:20:50 volumiolounge sudo[1048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 15:20:50 volumiolounge sudo[1048]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:50 volumiolounge sudo[1048]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:50 volumiolounge sudo[1050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 15:20:50 volumiolounge sudo[1050]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:50 volumiolounge sudo[1050]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:50 volumiolounge volumio[844]: verbose: New Socket.io Connection to 192.168.30.10 from 192.168.30.239 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5 Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetVisibleSources Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:20:50 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 10 15:20:50 volumiolounge volumio[844]: info: Received Get System Info Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 15:20:50 volumiolounge volumio[844]: info: Discovery: Getting this device information Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:20:50 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:20:50 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:50 volumiolounge volumio[844]: info: Listing playlists Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 10 15:20:50 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 15:20:50 volumiolounge volumio[844]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 10 15:20:52 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 15:20:52 volumiolounge volumio[844]: info: Received Get System Info Mar 10 15:20:52 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 15:20:52 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 15:20:52 volumiolounge volumio[844]: info: Discovery: Getting this device information Mar 10 15:20:52 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:20:52 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:52 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 15:20:52 volumiolounge sudo[1054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 15:20:52 volumiolounge sudo[1054]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:52 volumiolounge sudo[1054]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:52 volumiolounge sudo[1056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 15:20:52 volumiolounge sudo[1056]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:52 volumiolounge sudo[1056]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:52 volumiolounge sudo[1060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 10 15:20:52 volumiolounge sudo[1060]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 15:20:52 volumiolounge systemd[1]: Started UPnP Renderer front-end to MPD. Mar 10 15:20:52 volumiolounge sudo[1060]: pam_unix(sudo:session): session closed for user root Mar 10 15:20:52 volumiolounge volumio[844]: info: Upmpdcli Daemon Started Mar 10 15:20:52 volumiolounge volumio[1062]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 10 15:20:52 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 10 15:20:53 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 15:20:53 volumiolounge volumio[844]: info: Received Get System Info Mar 10 15:20:53 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 15:20:53 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 15:20:53 volumiolounge volumio[844]: info: Discovery: Getting this device information Mar 10 15:20:53 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:20:53 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:20:53 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 15:20:54 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 10 15:20:55 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetQueue Mar 10 15:20:55 volumiolounge volumio[844]: info: CoreStateMachine::getQueue Mar 10 15:20:55 volumiolounge volumio[844]: info: CorePlayQueue::getQueue Mar 10 15:20:55 volumiolounge systemd[1]: systemd-hostnamed.service: Succeeded. Mar 10 15:20:59 volumiolounge volumio[844]: Searching plugin music_service/mpd Mar 10 15:20:59 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , search Mar 10 15:20:59 volumiolounge volumio[844]: info: All search sources collected, pushing search results Mar 10 15:21:00 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:00 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:00 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:00 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:00 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:00 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:01 volumiolounge volumio[844]: Searching plugin music_service/mpd Mar 10 15:21:01 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , search Mar 10 15:21:01 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:01 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:01 volumiolounge volumio[844]: info: All search sources collected, pushing search results Mar 10 15:21:01 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:01 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:01 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:01 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:02 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:02 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:02 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:02 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:02 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:02 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:02 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:02 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:06 volumiolounge volumio[844]: Searching plugin music_service/mpd Mar 10 15:21:06 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , search Mar 10 15:21:06 volumiolounge volumio[844]: error: MyVolumio Plugin failed to start in a timely fashion Mar 10 15:21:06 volumiolounge volumio[844]: info: BOOT COMPLETED Mar 10 15:21:06 volumiolounge volumio[844]: [Metrics] CommandRouter: 26s 157.28ms Mar 10 15:21:06 volumiolounge volumio[844]: info: CoreCommandRouter::volumiosetStartupVolume Mar 10 15:21:06 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 15:21:06 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 15:21:06 volumiolounge volumio[844]: info: CoreCommandRouter::Close All Modals sent Mar 10 15:21:06 volumiolounge volumio[844]: info: CoreCommandRouter::Close All Modals sent Mar 10 15:21:06 volumiolounge volumio[1062]: .......................................................................................................................................................++++ Mar 10 15:21:06 volumiolounge volumio[844]: info: All search sources collected, pushing search results Mar 10 15:21:07 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 10 15:21:07 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 10 15:21:07 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 10 15:21:07 volumiolounge volumio[844]: Searching plugin music_service/mpd Mar 10 15:21:07 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , search Mar 10 15:21:07 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:07 volumiolounge volumio[844]: info: All search sources collected, pushing search results Mar 10 15:21:08 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:08 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:08 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:08 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 15:21:08 volumiolounge volumio[844]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 10 15:21:08 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 10 15:21:08 volumiolounge volumio[844]: info: Received Get System Version Mar 10 15:21:08 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 15:21:09 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:09 volumiolounge volumio[844]: info: Received Get System Info Mar 10 15:21:09 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 15:21:09 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 15:21:09 volumiolounge volumio[844]: info: Discovery: Getting this device information Mar 10 15:21:09 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:21:09 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:09 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 15:21:09 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:09 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:09 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:09 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:09 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:10 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:10 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:21:10 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:10 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:10 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:10 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:10 volumiolounge volumio[1062]: ...............................................++++ Mar 10 15:21:10 volumiolounge volumio[1062]: e is 65537 (0x010001) Mar 10 15:21:10 volumiolounge volumio[1062]: writing RSA key Mar 10 15:21:10 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:10 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:11 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:11 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:21:11 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:21:11 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:11 volumiolounge volumio[844]: Searching plugin music_service/mpd Mar 10 15:21:11 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , search Mar 10 15:21:11 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:11 volumiolounge volumio[844]: info: All search sources collected, pushing search results Mar 10 15:21:12 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:12 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 15:21:12 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 15:21:12 volumiolounge volumio[844]: info: Discovery: Getting this device information Mar 10 15:21:12 volumiolounge volumio[844]: info: CoreCommandRouter::volumioGetState Mar 10 15:21:12 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:12 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 15:21:12 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:12 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:12 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:21:12 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:12 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:12 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:13 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:21:13 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:13 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:13 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:13 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:13 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:13 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:13 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:14 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 10 15:21:14 volumiolounge volumio[844]: info: CURURI: albums://Caro%20Emerald/The%20Shocking%20Miss%20Emerald Mar 10 15:21:14 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:14 volumiolounge volumio[844]: info: Preload queue cleared Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/01 Miss Emerald_ Intro.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/02 One Day.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/03 Coming Back As a Man.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/04 Tangled Up.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/05 Completely.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/06 Black Valentine.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/07 Pack Up the Louie.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/08 I Belong To You.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/09 The Maestro.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/10 Liquid Lunch.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/11 Excuse My French.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/12 Paris.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/13 My 2 Cents.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/14 The Wonderful In You.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Preloading song: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/15 Tell Me How Long.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/01 Miss Emerald_ Intro.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F01%20Miss%20Emerald_%20Intro.m4a&metadata=false Mar 10 15:21:14 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/01 Miss Emerald_ Intro.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/02 One Day.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F02%20One%20Day.m4a&metadata=false Mar 10 15:21:14 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/02 One Day.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/03 Coming Back As a Man.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/04 Tangled Up.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/05 Completely.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/06 Black Valentine.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F03%20Coming%20Back%20As%20a%20Man.m4a&metadata=false Mar 10 15:21:14 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/03 Coming Back As a Man.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F04%20Tangled%20Up.m4a&metadata=false Mar 10 15:21:14 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/04 Tangled Up.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F05%20Completely.m4a&metadata=false Mar 10 15:21:14 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/05 Completely.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F06%20Black%20Valentine.m4a&metadata=false Mar 10 15:21:14 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/06 Black Valentine.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/07 Pack Up the Louie.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/08 I Belong To You.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/09 The Maestro.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/10 Liquid Lunch.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F07%20Pack%20Up%20the%20Louie.m4a&metadata=false Mar 10 15:21:14 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/07 Pack Up the Louie.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F08%20I%20Belong%20To%20You.m4a&metadata=false Mar 10 15:21:14 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/08 I Belong To You.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F09%20The%20Maestro.m4a&metadata=false Mar 10 15:21:14 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/09 The Maestro.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F10%20Liquid%20Lunch.m4a&metadata=false Mar 10 15:21:14 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/10 Liquid Lunch.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/11 Excuse My French.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F11%20Excuse%20My%20French.m4a&metadata=false Mar 10 15:21:14 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/11 Excuse My French.m4a Mar 10 15:21:14 volumiolounge volumio[844]: info: No valid Plugin REST Endpoint Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/12 Paris.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/13 My 2 Cents.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/14 The Wonderful In You.m4a in service mpd Mar 10 15:21:14 volumiolounge volumio[844]: info: Exploding uri music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/15 Tell Me How Long.m4a in service mpd Mar 10 15:21:15 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F12%20Paris.m4a&metadata=false Mar 10 15:21:15 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/12 Paris.m4a Mar 10 15:21:15 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F13%20My%202%20Cents.m4a&metadata=false Mar 10 15:21:15 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/13 My 2 Cents.m4a Mar 10 15:21:15 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F14%20The%20Wonderful%20In%20You.m4a&metadata=false Mar 10 15:21:15 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/14 The Wonderful In You.m4a Mar 10 15:21:15 volumiolounge volumio[844]: info: ALBUMART /albumart?cacheid=681&web=Caro%20Emerald/The%20Shocking%20Miss%20Emerald/extralarge&path=%2Fmnt%2FNAS%2FTruenas%2FCaro%20Emerald%2FThe%20Shocking%20Miss%20Emerald%2F15%20Tell%20Me%20How%20Long.m4a&metadata=false Mar 10 15:21:15 volumiolounge volumio[844]: info: URI /mnt/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/15 Tell Me How Long.m4a Mar 10 15:21:15 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:15 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:15 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:15 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:15 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:15 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:15 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:16 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:21:16 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:21:16 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:16 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 15:21:16 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 15:21:16 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 15:21:16 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:21:16 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:16 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:17 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:21:17 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:17 volumiolounge volumio[844]: info: Preload queue cleared Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::ClearQueue Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::stop Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 15:21:17 volumiolounge volumio[844]: info: CorePlayQueue::clearPlayQueue Mar 10 15:21:17 volumiolounge volumio[844]: info: CorePlayQueue::saveQueue Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushQueue Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::addQueueItems Mar 10 15:21:17 volumiolounge volumio[844]: info: CorePlayQueue::addQueueItems Mar 10 15:21:17 volumiolounge volumio[844]: info: Preload queue cleared Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/01 Miss Emerald_ Intro.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/01 Miss Emerald_ Intro.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/02 One Day.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/02 One Day.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/03 Coming Back As a Man.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/03 Coming Back As a Man.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/04 Tangled Up.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/04 Tangled Up.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/05 Completely.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/05 Completely.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/06 Black Valentine.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/06 Black Valentine.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/07 Pack Up the Louie.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/07 Pack Up the Louie.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/08 I Belong To You.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/08 I Belong To You.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/09 The Maestro.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/09 The Maestro.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/10 Liquid Lunch.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/10 Liquid Lunch.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/11 Excuse My French.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/11 Excuse My French.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/12 Paris.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/12 Paris.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/13 My 2 Cents.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/13 My 2 Cents.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/14 The Wonderful In You.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/14 The Wonderful In You.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Adding Item to queue: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/15 Tell Me How Long.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: Using cached record of: music-library/NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/15 Tell Me How Long.m4a Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushQueue Mar 10 15:21:17 volumiolounge volumio[844]: info: CorePlayQueue::saveQueue Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::updateTrackBlock Mar 10 15:21:17 volumiolounge volumio[844]: info: CorePlayQueue::getTrackBlock Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPlay Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::play index 1 Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 15:21:17 volumiolounge volumio[1017]: [Vollibrespot] : couldn't parse packet from 192.168.30.1:5353: type 47 is invalid Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::stop Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::play index undefined Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 15:21:17 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 1 Mar 10 15:21:17 volumiolounge volumio[844]: info: CoreStateMachine::startPlaybackTimer Mar 10 15:21:17 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 1 Mar 10 15:21:17 volumiolounge volumio[844]: verbose: ControllerMpd::clearAddPlayTracks NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/02 One Day.m4a Mar 10 15:21:17 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 15:21:17 volumiolounge volumio[844]: info: sendMpdCommand stop took 5 milliseconds Mar 10 15:21:17 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand clear Mar 10 15:21:17 volumiolounge volumio[844]: info: Mar 10 15:21:17 volumiolounge volumio[844]: ---------------------------- MPD announces system playlist update Mar 10 15:21:17 volumiolounge volumio[844]: info: Ignoring MPD Status Update Mar 10 15:21:17 volumiolounge volumio[844]: info: sendMpdCommand clear took 160 milliseconds Mar 10 15:21:17 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand add "NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/02 One Day.m4a" Mar 10 15:21:17 volumiolounge volumio[844]: error: updateQueue error: null Mar 10 15:21:17 volumiolounge volumio[844]: info: Mar 10 15:21:17 volumiolounge volumio[844]: ---------------------------- MPD announces system playlist update Mar 10 15:21:17 volumiolounge volumio[844]: info: Ignoring MPD Status Update Mar 10 15:21:17 volumiolounge volumio[844]: info: ------------------------------ 5ms Mar 10 15:21:17 volumiolounge volumio[844]: info: sendMpdCommand add "NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/02 One Day.m4a" took 5 milliseconds Mar 10 15:21:17 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand play Mar 10 15:21:17 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:17 volumiolounge volumio[844]: info: ------------------------------ 160ms Mar 10 15:21:17 volumiolounge volumio[844]: info: sendMpdCommand play took 159 milliseconds Mar 10 15:21:17 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:18 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:18 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:18 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:18 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:18 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:19 volumiolounge kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Mar 10 15:21:19 volumiolounge volumio[844]: info: Mar 10 15:21:19 volumiolounge volumio[844]: ---------------------------- MPD announces state update: player Mar 10 15:21:19 volumiolounge volumio[844]: info: ControllerMpd::getState Mar 10 15:21:19 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand status Mar 10 15:21:19 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:19 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:19 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:19 volumiolounge volumio[844]: info: Mar 10 15:21:19 volumiolounge volumio[844]: ---------------------------- MPD announces state update: player Mar 10 15:21:19 volumiolounge volumio[844]: info: ControllerMpd::getState Mar 10 15:21:19 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand status Mar 10 15:21:19 volumiolounge volumio[844]: info: sendMpdCommand status took 134 milliseconds Mar 10 15:21:19 volumiolounge volumio[844]: verbose: ControllerMpd::parseState Mar 10 15:21:19 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 15:21:19 volumiolounge volumio[844]: info: sendMpdCommand status took 8 milliseconds Mar 10 15:21:19 volumiolounge volumio[844]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 10 15:21:19 volumiolounge volumio[844]: verbose: ControllerMpd::parseState Mar 10 15:21:19 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 15:21:19 volumiolounge volumio[844]: verbose: ControllerMpd::parseTrackInfo Mar 10 15:21:19 volumiolounge volumio[844]: info: ControllerMpd::pushState Mar 10 15:21:19 volumiolounge volumio[844]: info: CoreCommandRouter::servicePushState Mar 10 15:21:19 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 1 Mar 10 15:21:19 volumiolounge volumio[844]: verbose: STATE SERVICE {"status":"play","position":0,"seek":948,"duration":273,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"259 Kbps","isStreaming":false,"title":"One Day","artist":"Caro Emerald","album":"The Shocking Miss Emerald","uri":"NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/02 One Day.m4a","trackType":"m4a"} Mar 10 15:21:19 volumiolounge volumio[844]: verbose: CURRENT POSITION 1 Mar 10 15:21:19 volumiolounge volumio[844]: info: CoreStateMachine::syncState stateService play Mar 10 15:21:19 volumiolounge volumio[844]: info: CoreStateMachine::syncState currentStatus stop Mar 10 15:21:19 volumiolounge volumio[844]: info: ------------------------------ 153ms Mar 10 15:21:19 volumiolounge volumio[844]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 10 15:21:19 volumiolounge volumio[844]: verbose: ControllerMpd::parseTrackInfo Mar 10 15:21:19 volumiolounge volumio[844]: info: ControllerMpd::pushState Mar 10 15:21:19 volumiolounge volumio[844]: info: CoreCommandRouter::servicePushState Mar 10 15:21:19 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 1 Mar 10 15:21:19 volumiolounge volumio[844]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1040,"duration":273,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"259 Kbps","isStreaming":false,"title":"One Day","artist":"Caro Emerald","album":"The Shocking Miss Emerald","uri":"NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/02 One Day.m4a","trackType":"m4a"} Mar 10 15:21:19 volumiolounge volumio[844]: verbose: CURRENT POSITION 1 Mar 10 15:21:19 volumiolounge volumio[844]: info: CoreStateMachine::syncState stateService play Mar 10 15:21:19 volumiolounge volumio[844]: info: CoreStateMachine::syncState currentStatus play Mar 10 15:21:19 volumiolounge volumio[844]: info: Received an update from plugin. extracting info from payload Mar 10 15:21:19 volumiolounge volumio[844]: info: CoreStateMachine::pushState Mar 10 15:21:19 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 1 Mar 10 15:21:19 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 15:21:19 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushState Mar 10 15:21:19 volumiolounge volumio[844]: info: CoreStateMachine::pushState Mar 10 15:21:19 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 1 Mar 10 15:21:19 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushState Mar 10 15:21:19 volumiolounge volumio[844]: info: ------------------------------ 44ms Mar 10 15:21:20 volumiolounge volumio[844]: info: Preload queue cleared Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::ClearQueue Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::stop Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::stPlaybackTimer Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::updateTrackBlock Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::getTrackBlock Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::pushState Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 1 Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushState Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::serviceStop Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 1 Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::serviceStop Mar 10 15:21:20 volumiolounge volumio[844]: info: ControllerMpd::stop Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::clearPlayQueue Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::saveQueue Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushQueue Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::addQueueItems Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::addQueueItems Mar 10 15:21:20 volumiolounge volumio[844]: info: Preload queue cleared Mar 10 15:21:20 volumiolounge volumio[844]: info: Adding Item to queue: albums://Caro%20Emerald/The%20Shocking%20Miss%20Emerald Mar 10 15:21:20 volumiolounge volumio[844]: info: Exploding uri albums://Caro%20Emerald/The%20Shocking%20Miss%20Emerald in service mpd Mar 10 15:21:20 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:20 volumiolounge volumio[844]: info: Mar 10 15:21:20 volumiolounge volumio[844]: ---------------------------- MPD announces state update: player Mar 10 15:21:20 volumiolounge volumio[844]: info: sendMpdCommand stop took 20 milliseconds Mar 10 15:21:20 volumiolounge volumio[844]: info: ControllerMpd::getState Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand status Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushQueue Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::saveQueue Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::updateTrackBlock Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::getTrackBlock Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPlay Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::play index 0 Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::stop Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::play index undefined Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::startPlaybackTimer Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::clearAddPlayTracks NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/01 Miss Emerald_ Intro.m4a Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 15:21:20 volumiolounge volumio[844]: info: sendMpdCommand status took 16 milliseconds Mar 10 15:21:20 volumiolounge volumio[844]: info: sendMpdCommand stop took 7 milliseconds Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::parseState Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand clear Mar 10 15:21:20 volumiolounge volumio[844]: info: Mar 10 15:21:20 volumiolounge volumio[844]: ---------------------------- MPD announces system playlist update Mar 10 15:21:20 volumiolounge volumio[844]: info: Ignoring MPD Status Update Mar 10 15:21:20 volumiolounge volumio[844]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 10 15:21:20 volumiolounge volumio[844]: info: sendMpdCommand clear took 7 milliseconds Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::parseTrackInfo Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand add "NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/01 Miss Emerald_ Intro.m4a" Mar 10 15:21:20 volumiolounge volumio[844]: info: ControllerMpd::pushState Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::servicePushState Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::pushState Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushState Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:20 volumiolounge volumio[844]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"One Day","artist":"Caro Emerald","album":"The Shocking Miss Emerald","uri":"NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/02 One Day.m4a","trackType":"m4a"} Mar 10 15:21:20 volumiolounge volumio[844]: verbose: CURRENT POSITION 0 Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::syncState stateService stop Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::syncState currentStatus stop Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::pushState Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushState Mar 10 15:21:20 volumiolounge volumio[844]: info: No code Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreStateMachine::pushState Mar 10 15:21:20 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:20 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushState Mar 10 15:21:20 volumiolounge volumio[844]: info: ------------------------------ 48ms Mar 10 15:21:20 volumiolounge volumio[844]: error: updateQueue error: null Mar 10 15:21:20 volumiolounge volumio[844]: info: Mar 10 15:21:20 volumiolounge volumio[844]: ---------------------------- MPD announces system playlist update Mar 10 15:21:20 volumiolounge volumio[844]: info: Ignoring MPD Status Update Mar 10 15:21:20 volumiolounge volumio[844]: info: ------------------------------ 174ms Mar 10 15:21:20 volumiolounge volumio[844]: info: sendMpdCommand add "NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/01 Miss Emerald_ Intro.m4a" took 172 milliseconds Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand play Mar 10 15:21:20 volumiolounge volumio[844]: info: ------------------------------ 8ms Mar 10 15:21:20 volumiolounge volumio[844]: info: sendMpdCommand play took 6 milliseconds Mar 10 15:21:20 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:20 volumiolounge volumio[844]: info: Mar 10 15:21:20 volumiolounge volumio[844]: ---------------------------- MPD announces state update: player Mar 10 15:21:20 volumiolounge volumio[844]: info: ControllerMpd::getState Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand status Mar 10 15:21:20 volumiolounge volumio[844]: info: Mar 10 15:21:20 volumiolounge volumio[844]: ---------------------------- MPD announces state update: player Mar 10 15:21:20 volumiolounge volumio[844]: info: ControllerMpd::getState Mar 10 15:21:20 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand status Mar 10 15:21:21 volumiolounge volumio[844]: info: sendMpdCommand status took 5 milliseconds Mar 10 15:21:21 volumiolounge volumio[844]: verbose: ControllerMpd::parseState Mar 10 15:21:21 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 15:21:21 volumiolounge volumio[844]: info: sendMpdCommand status took 5 milliseconds Mar 10 15:21:21 volumiolounge volumio[844]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 10 15:21:21 volumiolounge volumio[844]: verbose: ControllerMpd::parseState Mar 10 15:21:21 volumiolounge volumio[844]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 15:21:21 volumiolounge volumio[844]: verbose: ControllerMpd::parseTrackInfo Mar 10 15:21:21 volumiolounge volumio[844]: info: ControllerMpd::pushState Mar 10 15:21:21 volumiolounge volumio[844]: info: CoreCommandRouter::servicePushState Mar 10 15:21:21 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:21 volumiolounge volumio[844]: verbose: STATE SERVICE {"status":"play","position":0,"seek":948,"duration":39,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"269 Kbps","isStreaming":false,"title":"Miss Emerald: Intro","artist":"Caro Emerald","album":"The Shocking Miss Emerald","uri":"NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/01 Miss Emerald_ Intro.m4a","trackType":"m4a"} Mar 10 15:21:21 volumiolounge volumio[844]: verbose: CURRENT POSITION 0 Mar 10 15:21:21 volumiolounge volumio[844]: info: CoreStateMachine::syncState stateService play Mar 10 15:21:21 volumiolounge volumio[844]: info: CoreStateMachine::syncState currentStatus stop Mar 10 15:21:21 volumiolounge volumio[844]: info: ------------------------------ 17ms Mar 10 15:21:21 volumiolounge volumio[844]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 10 15:21:21 volumiolounge volumio[844]: verbose: ControllerMpd::parseTrackInfo Mar 10 15:21:21 volumiolounge volumio[844]: info: ControllerMpd::pushState Mar 10 15:21:21 volumiolounge volumio[844]: info: CoreCommandRouter::servicePushState Mar 10 15:21:21 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:21 volumiolounge volumio[844]: verbose: STATE SERVICE {"status":"play","position":0,"seek":948,"duration":39,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"269 Kbps","isStreaming":false,"title":"Miss Emerald: Intro","artist":"Caro Emerald","album":"The Shocking Miss Emerald","uri":"NAS/Truenas/Caro Emerald/The Shocking Miss Emerald/01 Miss Emerald_ Intro.m4a","trackType":"m4a"} Mar 10 15:21:21 volumiolounge volumio[844]: verbose: CURRENT POSITION 0 Mar 10 15:21:21 volumiolounge volumio[844]: info: CoreStateMachine::syncState stateService play Mar 10 15:21:21 volumiolounge volumio[844]: info: CoreStateMachine::syncState currentStatus play Mar 10 15:21:21 volumiolounge volumio[844]: info: Received an update from plugin. extracting info from payload Mar 10 15:21:21 volumiolounge volumio[844]: info: CoreStateMachine::pushState Mar 10 15:21:21 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:21 volumiolounge volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 15:21:21 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushState Mar 10 15:21:21 volumiolounge volumio[844]: info: CoreStateMachine::pushState Mar 10 15:21:21 volumiolounge volumio[844]: info: CorePlayQueue::getTrack 0 Mar 10 15:21:21 volumiolounge volumio[844]: info: CoreCommandRouter::volumioPushState Mar 10 15:21:21 volumiolounge volumio[844]: info: ------------------------------ 33ms Mar 10 15:21:21 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:21 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:21 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:22 volumiolounge volumio[844]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 10 15:21:22 volumiolounge volumio[844]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 15:21:22 volumiolounge volumio[844]: Error: certificate is not yet valid Mar 10 15:21:22 volumiolounge volumio[844]: at TLSSocket.onConnectSecure (_tls_wrap.js:1497:34) Mar 10 15:21:22 volumiolounge volumio[844]: at TLSSocket.emit (events.js:315:20) Mar 10 15:21:22 volumiolounge volumio[844]: at TLSSocket._finishInit (_tls_wrap.js:932:8) Mar 10 15:21:22 volumiolounge volumio[844]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:706:12) { Mar 10 15:21:22 volumiolounge volumio[844]: code: 'CERT_NOT_YET_VALID' Mar 10 15:21:22 volumiolounge volumio[844]: } Mar 10 15:21:22 volumiolounge volumio[844]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 15:21:22 volumiolounge sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-10 15:20 Mar 10 15:21:22 volumiolounge sudo[1125]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"